"./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptDrive: -verbose" - Starting (try 1/5)
2026/11/05 04:31:12 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi"
2026/11/05 04:31:12 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:31:12 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0"
2026/11/05 04:31:13 DEBUG : Creating backend with remote "/tmp/rclone4040252718"
=== 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
    multithread_test.go:120: multithread writing not supported
--- SKIP: TestMultithreadCopy (0.20s)
=== RUN   TestMultithreadCopyAbort
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
    multithread_test.go:120: multithread writing not supported
--- SKIP: TestMultithreadCopyAbort (0.23s)
=== RUN   TestMultithreadCopyWriterAtErrors
=== RUN   TestMultithreadCopyWriterAtErrors/open/fatal=false
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
=== RUN   TestMultithreadCopyWriterAtErrors/open/fatal=true
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
=== RUN   TestMultithreadCopyWriterAtErrors/write/fatal=false
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/11/05 04:31:13 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 1
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 0
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 2
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found
=== RUN   TestMultithreadCopyWriterAtErrors/write/fatal=true
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/11/05 04:31:13 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 1
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 2
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 0
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found
=== RUN   TestMultithreadCopyWriterAtErrors/close/fatal=false
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/11/05 04:31:13 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 1
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 2
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 3
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 0
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found
=== RUN   TestMultithreadCopyWriterAtErrors/close/fatal=true
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/11/05 04:31:13 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 1
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 0
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 2
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting
2026/11/05 04:31:13 DEBUG : file.txt: writing chunk 3
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/11/05 04:31:13 DEBUG : file.txt: multi-thread copy: abort failed: multi-thread copy: failed to find temp file when aborting chunk writer: object not found
--- PASS: TestMultithreadCopyWriterAtErrors (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/open/fatal=false (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/open/fatal=true (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/write/fatal=false (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/write/fatal=true (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/close/fatal=false (0.00s)
    --- PASS: TestMultithreadCopyWriterAtErrors/close/fatal=true (0.00s)
=== RUN   TestSizeDiffers
2026/11/05 04:31:13 DEBUG : a: size = 0 OK
2026/11/05 04:31:13 DEBUG : a: size = 1 (memory)
2026/11/05 04:31:13 DEBUG : a: size = 2 (memory)
--- PASS: TestSizeDiffers (0.00s)
=== RUN   TestDirTransferEntry
--- PASS: TestDirTransferEntry (0.00s)
=== RUN   TestReOpen
=== RUN   TestReOpen/Normal
=== RUN   TestReOpen/Normal/Basics
2026/11/05 04:31:13 DEBUG : potato: Seek from 10 to 0
=== RUN   TestReOpen/Normal/ErrorAtStart
=== RUN   TestReOpen/Normal/WithErrors
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/Normal/TooManyErrors
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/Normal/ReadAt
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/Normal/Seek
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Seek from 5 to 2
=== RUN   TestReOpen/Normal/AccountRead
=== RUN   TestReOpen/Normal/AccountReadDelay
2026/11/05 04:31:13 DEBUG : potato: Seek from 10 to 0
2026/11/05 04:31:13 DEBUG : potato: Seek from 10 to 0
2026/11/05 04:31:13 DEBUG : potato: Seek from 10 to 0
=== RUN   TestReOpen/Normal/AccountReadError
=== RUN   TestReOpen/WithRangeOption
=== RUN   TestReOpen/WithRangeOption/Basics
2026/11/05 04:31:13 DEBUG : potato: Seek from 7 to 0
=== RUN   TestReOpen/WithRangeOption/ErrorAtStart
=== RUN   TestReOpen/WithRangeOption/WithErrors
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/WithRangeOption/TooManyErrors
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/WithRangeOption/ReadAt
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/WithRangeOption/Seek
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Seek from 5 to 2
2026/11/05 04:31:13 DEBUG : potato: Seek from 7 to 4
=== RUN   TestReOpen/WithRangeOption/AccountRead
=== RUN   TestReOpen/WithRangeOption/AccountReadDelay
2026/11/05 04:31:13 DEBUG : potato: Seek from 7 to 0
2026/11/05 04:31:13 DEBUG : potato: Seek from 7 to 0
2026/11/05 04:31:13 DEBUG : potato: Seek from 7 to 0
=== RUN   TestReOpen/WithRangeOption/AccountReadError
=== RUN   TestReOpen/WithSeekOption
=== RUN   TestReOpen/WithSeekOption/Basics
2026/11/05 04:31:13 DEBUG : potato: Seek from 8 to 0
=== RUN   TestReOpen/WithSeekOption/ErrorAtStart
=== RUN   TestReOpen/WithSeekOption/WithErrors
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/WithSeekOption/TooManyErrors
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/WithSeekOption/ReadAt
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/WithSeekOption/Seek
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Seek from 5 to 2
2026/11/05 04:31:13 DEBUG : potato: Seek from 7 to 5
=== RUN   TestReOpen/WithSeekOption/AccountRead
=== RUN   TestReOpen/WithSeekOption/AccountReadDelay
2026/11/05 04:31:13 DEBUG : potato: Seek from 8 to 0
2026/11/05 04:31:13 DEBUG : potato: Seek from 8 to 0
2026/11/05 04:31:13 DEBUG : potato: Seek from 8 to 0
=== RUN   TestReOpen/WithSeekOption/AccountReadError
=== RUN   TestReOpen/UnknownSize
=== RUN   TestReOpen/UnknownSize/Basics
2026/11/05 04:31:13 DEBUG : potato: Seek from 9 to 0
=== RUN   TestReOpen/UnknownSize/ErrorAtStart
=== RUN   TestReOpen/UnknownSize/WithErrors
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/UnknownSize/TooManyErrors
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/11/05 04:31:13 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/UnknownSize/ReadAt
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/UnknownSize/Seek
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/05 04:31:13 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/05 04:31:13 DEBUG : potato: Seek from 5 to 2
2026/11/05 04:31:13 DEBUG : potato: Seek from 7 to 6
=== RUN   TestReOpen/UnknownSize/AccountRead
=== RUN   TestReOpen/UnknownSize/AccountReadDelay
2026/11/05 04:31:13 DEBUG : potato: Seek from 9 to 0
2026/11/05 04:31:13 DEBUG : potato: Seek from 9 to 0
2026/11/05 04:31:13 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:31:15 DEBUG : rutabaga: md5 = 121f70373115ee3dcb0cb389d027a06f OK
=== RUN   TestCheck/1
=== RUN   TestCheck/2
2026/11/05 04:31:17 DEBUG : empty space: md5 = 988906c564e76890bc33c2722bf541e0 OK
=== RUN   TestCheck/3
2026/11/05 04:31:19 DEBUG : potato2: md5 = 19bdd6606d6e33ea9554a3ad8b1f8df3 OK
=== RUN   TestCheck/4
=== RUN   TestCheck/5
2026/11/05 04:31:21 DEBUG : remotepotato: md5 = 47873fd413403cfe8a712931c2ae9497 OK
=== RUN   TestCheck/6
=== RUN   TestCheck/7
--- PASS: TestCheck (11.22s)
    --- PASS: TestCheck/1 (0.22s)
    --- PASS: TestCheck/2 (0.22s)
    --- PASS: TestCheck/3 (0.24s)
    --- PASS: TestCheck/4 (0.24s)
    --- PASS: TestCheck/5 (0.26s)
    --- PASS: TestCheck/6 (0.27s)
    --- PASS: TestCheck/7 (0.24s)
=== RUN   TestCheckFsError
2026/11/05 04:31:24 DEBUG : Creating backend with remote "nonexistent"
2026/11/05 04:31:24 DEBUG : Creating backend with remote "nonexistent"
2026/11/05 04:31:24 DEBUG : Local file system at nonexistent: Waiting for checks to finish
2026/11/05 04:31:24 ERROR : Local file system at nonexistent: error reading source root directory: directory not found
2026/11/05 04:31:24 NOTICE: Local file system at nonexistent: 0 differences found
2026/11/05 04:31:24 NOTICE: Local file system at nonexistent: 2 errors while checking
--- PASS: TestCheckFsError (0.00s)
=== RUN   TestCheckDownload
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:31:26 DEBUG : rutabaga: md5 = bceeb2e6f8a5fe67b71580c87e645928 OK
=== RUN   TestCheckDownload/1
=== RUN   TestCheckDownload/2
2026/11/05 04:31:29 DEBUG : empty space: md5 = fc610e130bf7f20f087662c83e23c7ae OK
=== RUN   TestCheckDownload/3
2026/11/05 04:31:32 DEBUG : potato2: md5 = 0ca87ec40d72d2057d5fbcf291177514 OK
=== RUN   TestCheckDownload/4
=== RUN   TestCheckDownload/5
2026/11/05 04:31:35 DEBUG : remotepotato: md5 = 12069ee7fa224c46167569d0496efaa7 OK
=== RUN   TestCheckDownload/6
=== RUN   TestCheckDownload/7
--- PASS: TestCheckDownload (14.91s)
    --- PASS: TestCheckDownload/1 (0.92s)
    --- PASS: TestCheckDownload/2 (0.84s)
    --- PASS: TestCheckDownload/3 (0.74s)
    --- PASS: TestCheckDownload/4 (0.88s)
    --- PASS: TestCheckDownload/5 (0.83s)
    --- PASS: TestCheckDownload/6 (0.72s)
    --- PASS: TestCheckDownload/7 (0.71s)
=== RUN   TestCheckSizeOnly
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:31:41 DEBUG : rutabaga: md5 = 33644a900322e01327a0cf78e50e6c32 OK
=== RUN   TestCheckSizeOnly/1
=== RUN   TestCheckSizeOnly/2
2026/11/05 04:31:43 DEBUG : empty space: md5 = 794cbd6fce32c639d843c209c60df374 OK
=== RUN   TestCheckSizeOnly/3
2026/11/05 04:31:45 DEBUG : potato2: md5 = f1a6854eb2f2bb677094cdf7a4dad486 OK
=== RUN   TestCheckSizeOnly/4
=== RUN   TestCheckSizeOnly/5
2026/11/05 04:31:47 DEBUG : remotepotato: md5 = efaa2807a290521d77aad470d1ffea04 OK
=== RUN   TestCheckSizeOnly/6
=== RUN   TestCheckSizeOnly/7
--- PASS: TestCheckSizeOnly (11.55s)
    --- PASS: TestCheckSizeOnly/1 (0.24s)
    --- PASS: TestCheckSizeOnly/2 (0.24s)
    --- PASS: TestCheckSizeOnly/3 (0.25s)
    --- PASS: TestCheckSizeOnly/4 (0.23s)
    --- PASS: TestCheckSizeOnly/5 (0.25s)
    --- PASS: TestCheckSizeOnly/6 (0.23s)
    --- PASS: TestCheckSizeOnly/7 (0.20s)
=== RUN   TestCheckEqualReaders
--- PASS: TestCheckEqualReaders (0.00s)
=== RUN   TestParseSumFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:31:52 DEBUG : test.sum: md5 = d0affcbbf7c6fd346365725d837a6566 OK
2026/11/05 04:31:53 NOTICE: test.sum: improperly formatted checksum line 4
2026/11/05 04:31:53 NOTICE: test.sum: improperly formatted checksum line 5
2026/11/05 04:31:53 NOTICE: test.sum: improperly formatted checksum line 6
2026/11/05 04:31:53 NOTICE: test.sum: 2 warning(s) suppressed...
2026/11/05 04:31:54 DEBUG : test.sum: md5 = a08ce1f62bbd295cd43f3654c9673a19 OK
2026/11/05 04:31:55 NOTICE: test.sum: improperly formatted checksum line 4
2026/11/05 04:31:55 NOTICE: test.sum: improperly formatted checksum line 5
2026/11/05 04:31:55 NOTICE: test.sum: improperly formatted checksum line 6
2026/11/05 04:31:55 NOTICE: test.sum: 2 warning(s) suppressed...
--- PASS: TestParseSumFile (5.49s)
=== RUN   TestCheckSum
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:31:56 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/data"
2026/11/05 04:31:56 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/vjrnln8ratgmqakfosrqe8espk"
    check_test.go:354: Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/data' lacks md5, skipping
--- SKIP: TestCheckSum (1.88s)
=== RUN   TestCheckSumDownload
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:31:58 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/data"
2026/11/05 04:31:58 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/vjrnln8ratgmqakfosrqe8espk"
2026/11/05 04:32:02 DEBUG : data/banana: md5 = 2ed88b1f439055201fbc7cbf2fa2022a OK
2026/11/05 04:32:03 DEBUG : test.sum: md5 = 99ec73326e99eaac7a792ecfee9efeaf OK
=== RUN   TestCheckSumDownload/subtest1
2026/11/05 04:32:07 DEBUG : data/potato: md5 = 210363fd2ec4c802dd0048a966c137f9 OK
2026/11/05 04:32:08 DEBUG : test.sum: md5 = bad84f1f6975c2b0f05a2a70f74389ec OK
=== RUN   TestCheckSumDownload/subtest2
2026/11/05 04:32:12 DEBUG : test.sum: md5 = 0207ddbfa8eb57057a561bc0bbf6be47 OK
=== RUN   TestCheckSumDownload/subtest3
2026/11/05 04:32:16 DEBUG : test.sum: md5 = af039e5e79ec2444a4864be13580fea6 OK
=== RUN   TestCheckSumDownload/subtest4
2026/11/05 04:32:20 DEBUG : test.sum: md5 = b3cf6d34a94636cf73d788ffd764abab OK
=== RUN   TestCheckSumDownload/subtest5
2026/11/05 04:32:23 DEBUG : test.sum: md5 = 89a597d1e12ec0ccd010b901fe9d3286 OK
=== RUN   TestCheckSumDownload/subtest6
2026/11/05 04:32:27 DEBUG : data/banana: md5 = 33baf645f98d0ed39f45e77c465034e9 OK
2026/11/05 04:32:28 DEBUG : data/potato: md5 = 595a84a0fafee4f3c8b965537863ed98 OK
2026/11/05 04:32:29 DEBUG : test.sum: md5 = 0bfa3fa378d668272369001ee7132fb2 OK
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (36.55s)
    --- PASS: TestCheckSumDownload/subtest1 (2.00s)
    --- PASS: TestCheckSumDownload/subtest2 (1.73s)
    --- PASS: TestCheckSumDownload/subtest3 (1.87s)
    --- PASS: TestCheckSumDownload/subtest4 (1.96s)
    --- PASS: TestCheckSumDownload/subtest5 (1.70s)
    --- PASS: TestCheckSumDownload/subtest6 (1.71s)
    --- PASS: TestCheckSumDownload/subtest7 (1.89s)
=== RUN   TestCheckSumConcurrency
2026/11/05 04:32:35 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK
2026/11/05 04:32:35 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK
2026/11/05 04:32:35 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK
2026/11/05 04:32:35 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK
2026/11/05 04:32:35 NOTICE: Mock file system at checkSum: 0 differences found
2026/11/05 04:32:35 NOTICE: Mock file system at checkSum: 4 matching files
--- PASS: TestCheckSumConcurrency (0.00s)
=== RUN   TestCheckSumDownloadConcurrency
2026/11/05 04:32:35 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK
2026/11/05 04:32:35 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK
2026/11/05 04:32:35 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK
2026/11/05 04:32:35 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK
2026/11/05 04:32:35 NOTICE: Mock file system at checkSum: 0 differences found
2026/11/05 04:32:35 NOTICE: Mock file system at checkSum: 4 matching files
--- PASS: TestCheckSumDownloadConcurrency (0.00s)
=== RUN   TestApplyTransforms
2026/11/05 04:32:35 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-koxuvoy3yada"
2026/11/05 04:32:35 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:32:35 DEBUG : Creating backend with remote "TestDrive:crypt/lfo4l0u4fdqlufrpgqgu8uh0c62bgva0k23aei80vb06c4u4ha30"
2026/11/05 04:32:36 DEBUG : Creating backend with remote "/tmp/rclone1109289862"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-koxuvoy3yada'", Local "Local file system at /tmp/rclone1109289862", Modify Window "1ms"
2026/11/05 04:32:38 DEBUG : hello, world!: md5 = de841638d19460a1ce7f1d05cd01b7c3 OK
upper checkfile vs. lower remote (without normalization)
2026/11/05 04:32:39 ERROR : hello, world!: sum not found
2026/11/05 04:32:39 ERROR : HELLO, WORLD!: file not in Encrypted drive 'TestCryptDrive:rclone-test-koxuvoy3yada'
2026/11/05 04:32:39 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxuvoy3yada': 1 files missing
2026/11/05 04:32:39 NOTICE: 1 hashes missing
2026/11/05 04:32:39 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxuvoy3yada': 1 differences found
2026/11/05 04:32:39 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxuvoy3yada': 2 errors while checking
upper checkfile vs. lower remote (with normalization)
2026/11/05 04:32:40 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:32:40 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxuvoy3yada': 0 differences found
2026/11/05 04:32:40 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-koxuvoy3yada': 1 matching files
2026/11/05 04:32:40 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-lonobeh5vala"
2026/11/05 04:32:40 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:32:40 DEBUG : Creating backend with remote "TestDrive:crypt/mdqm3mq918og32keb750ige1fo0jg23j9sj4i5kaj6pp634m6qcg"
2026/11/05 04:32:41 DEBUG : Creating backend with remote "/tmp/rclone2718054928"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-lonobeh5vala'", Local "Local file system at /tmp/rclone2718054928", Modify Window "1ms"
2026/11/05 04:32:43 DEBUG : HELLO, WORLD!: md5 = ed01bd0df865603045fb66d9651a8c8a OK
lower checkfile vs. upper remote (without normalization)
2026/11/05 04:32:43 ERROR : HELLO, WORLD!: sum not found
2026/11/05 04:32:43 ERROR : hello, world!: file not in Encrypted drive 'TestCryptDrive:rclone-test-lonobeh5vala'
2026/11/05 04:32:43 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-lonobeh5vala': 1 files missing
2026/11/05 04:32:43 NOTICE: 1 hashes missing
2026/11/05 04:32:43 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-lonobeh5vala': 1 differences found
2026/11/05 04:32:43 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-lonobeh5vala': 2 errors while checking
lower checkfile vs. upper remote (with normalization)
2026/11/05 04:32:44 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:32:44 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-lonobeh5vala': 0 differences found
2026/11/05 04:32:44 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-lonobeh5vala': 1 matching files
2026/11/05 04:32:44 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-rejinik2sobu"
2026/11/05 04:32:44 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:32:44 DEBUG : Creating backend with remote "TestDrive:crypt/uu5cbhoak452kkj7s1tia5oad3pd7t6o3f8k04q3eldnvoh91ifg"
2026/11/05 04:32:45 DEBUG : Creating backend with remote "/tmp/rclone3800002801"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-rejinik2sobu'", Local "Local file system at /tmp/rclone3800002801", Modify Window "1ms"
2026/11/05 04:32:47 DEBUG : HeLlO, wOrLd!: md5 = 9ec46af4b69679716c605e6c5f13cb64 OK
lower checkfile vs. upperlowermixed remote (without normalization)
2026/11/05 04:32:47 ERROR : HeLlO, wOrLd!: sum not found
2026/11/05 04:32:47 ERROR : hello, world!: file not in Encrypted drive 'TestCryptDrive:rclone-test-rejinik2sobu'
2026/11/05 04:32:47 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rejinik2sobu': 1 files missing
2026/11/05 04:32:47 NOTICE: 1 hashes missing
2026/11/05 04:32:47 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rejinik2sobu': 1 differences found
2026/11/05 04:32:47 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rejinik2sobu': 2 errors while checking
lower checkfile vs. upperlowermixed remote (with normalization)
2026/11/05 04:32:48 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:32:48 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rejinik2sobu': 0 differences found
2026/11/05 04:32:48 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rejinik2sobu': 1 matching files
2026/11/05 04:32:48 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-jacuzid7pavu"
2026/11/05 04:32:48 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:32:48 DEBUG : Creating backend with remote "TestDrive:crypt/kak3eane9j6qbd6p2v728j9h5thmb038ul5h5tvfiabetaebadvg"
2026/11/05 04:32:49 DEBUG : Creating backend with remote "/tmp/rclone1079799736"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-jacuzid7pavu'", Local "Local file system at /tmp/rclone1079799736", Modify Window "1ms"
2026/11/05 04:32:52 DEBUG : HELLO, WORLD!: md5 = d7553b672e03729eee91f48e80bea425 OK
upperlowermixed checkfile vs. upper remote (without normalization)
2026/11/05 04:32:52 ERROR : HELLO, WORLD!: sum not found
2026/11/05 04:32:52 ERROR : HeLlO, wOrLd!: file not in Encrypted drive 'TestCryptDrive:rclone-test-jacuzid7pavu'
2026/11/05 04:32:52 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jacuzid7pavu': 1 files missing
2026/11/05 04:32:52 NOTICE: 1 hashes missing
2026/11/05 04:32:52 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jacuzid7pavu': 1 differences found
2026/11/05 04:32:52 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jacuzid7pavu': 2 errors while checking
upperlowermixed checkfile vs. upper remote (with normalization)
2026/11/05 04:32:53 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:32:53 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jacuzid7pavu': 0 differences found
2026/11/05 04:32:53 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jacuzid7pavu': 1 matching files
2026/11/05 04:32:53 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-buvoxel9jama"
2026/11/05 04:32:53 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:32:53 DEBUG : Creating backend with remote "TestDrive:crypt/h3munitj040fbcbqt84mmovvcak4jooligha72u4vvah5empi9l0"
2026/11/05 04:32:54 DEBUG : Creating backend with remote "/tmp/rclone547868819"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-buvoxel9jama'", Local "Local file system at /tmp/rclone547868819", Modify Window "1ms"
2026/11/05 04:32:56 DEBUG : 測試_Русский___ě_áñ: md5 = 92bd589fbae2b82eb0c9a060a7a5d699 OK
NFD checkfile vs. NFC remote (without normalization)
2026/11/05 04:32:57 ERROR : 測試_Русский___ě_áñ: sum not found
2026/11/05 04:32:57 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-buvoxel9jama'
2026/11/05 04:32:57 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-buvoxel9jama': 1 files missing
2026/11/05 04:32:57 NOTICE: 1 hashes missing
2026/11/05 04:32:57 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-buvoxel9jama': 1 differences found
2026/11/05 04:32:57 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-buvoxel9jama': 2 errors while checking
NFD checkfile vs. NFC remote (with normalization)
2026/11/05 04:32:58 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:32:58 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-buvoxel9jama': 0 differences found
2026/11/05 04:32:58 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-buvoxel9jama': 1 matching files
2026/11/05 04:32:58 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-narapoh7tove"
2026/11/05 04:32:58 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:32:58 DEBUG : Creating backend with remote "TestDrive:crypt/temgs5fl8kt31fk161vpbrf5gtnusoe6t74b2rstpif6f9r61u00"
2026/11/05 04:32:59 DEBUG : Creating backend with remote "/tmp/rclone1538719083"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-narapoh7tove'", Local "Local file system at /tmp/rclone1538719083", Modify Window "1ms"
2026/11/05 04:33:01 DEBUG : 測試_Русский___ě_áñ: md5 = ca15c414179bf21fd7a134c65beaddeb OK
NFC checkfile vs. NFD remote (without normalization)
2026/11/05 04:33:01 ERROR : 測試_Русский___ě_áñ: sum not found
2026/11/05 04:33:01 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-narapoh7tove'
2026/11/05 04:33:01 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-narapoh7tove': 1 files missing
2026/11/05 04:33:01 NOTICE: 1 hashes missing
2026/11/05 04:33:01 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-narapoh7tove': 1 differences found
2026/11/05 04:33:01 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-narapoh7tove': 2 errors while checking
NFC checkfile vs. NFD remote (with normalization)
2026/11/05 04:33:02 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:33:02 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-narapoh7tove': 0 differences found
2026/11/05 04:33:02 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-narapoh7tove': 1 matching files
2026/11/05 04:33:02 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-mecusaq9sumu"
2026/11/05 04:33:02 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:33:02 DEBUG : Creating backend with remote "TestDrive:crypt/b3ljilqas839o876qmuaaju744ifm6o5djbo51joful19r1c00tg"
2026/11/05 04:33:03 DEBUG : Creating backend with remote "/tmp/rclone352949964"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-mecusaq9sumu'", Local "Local file system at /tmp/rclone352949964", Modify Window "1ms"
2026/11/05 04:33:05 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 42bbeddc0706aaf04b5dd431276d57a4 OK
NFDx2 checkfile vs. both remote (without normalization)
2026/11/05 04:33:06 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/11/05 04:33:06 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-mecusaq9sumu'
2026/11/05 04:33:06 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mecusaq9sumu': 1 files missing
2026/11/05 04:33:06 NOTICE: 1 hashes missing
2026/11/05 04:33:06 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mecusaq9sumu': 1 differences found
2026/11/05 04:33:06 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mecusaq9sumu': 2 errors while checking
NFDx2 checkfile vs. both remote (with normalization)
2026/11/05 04:33:06 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:33:06 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mecusaq9sumu': 0 differences found
2026/11/05 04:33:06 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mecusaq9sumu': 1 matching files
2026/11/05 04:33:06 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-bezafoc6zido"
2026/11/05 04:33:06 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:33:07 DEBUG : Creating backend with remote "TestDrive:crypt/idpci2boubf8svcc3m81s9nbprvl388o9fnjg3bqbb12pvsj0utg"
2026/11/05 04:33:07 DEBUG : Creating backend with remote "/tmp/rclone3561452194"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-bezafoc6zido'", Local "Local file system at /tmp/rclone3561452194", Modify Window "1ms"
2026/11/05 04:33:10 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 0ce0f2a0026e483d306ecbba8970319b OK
NFCx2 checkfile vs. both remote (without normalization)
2026/11/05 04:33:10 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/11/05 04:33:10 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-bezafoc6zido'
2026/11/05 04:33:10 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bezafoc6zido': 1 files missing
2026/11/05 04:33:10 NOTICE: 1 hashes missing
2026/11/05 04:33:10 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bezafoc6zido': 1 differences found
2026/11/05 04:33:10 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bezafoc6zido': 2 errors while checking
NFCx2 checkfile vs. both remote (with normalization)
2026/11/05 04:33:11 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:33:11 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bezafoc6zido': 0 differences found
2026/11/05 04:33:11 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-bezafoc6zido': 1 matching files
2026/11/05 04:33:11 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-hoqemax7wevu"
2026/11/05 04:33:11 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:33:11 DEBUG : Creating backend with remote "TestDrive:crypt/85k380npglpn9j5g3km0tfoocv1pbh5qnqe014n956qn2o8ckclg"
2026/11/05 04:33:12 DEBUG : Creating backend with remote "/tmp/rclone599813576"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-hoqemax7wevu'", Local "Local file system at /tmp/rclone599813576", Modify Window "1ms"
2026/11/05 04:33:14 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = e235ccbee548979a0021f33e71fb9d27 OK
both checkfile vs. NFDx2 remote (without normalization)
2026/11/05 04:33:14 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/11/05 04:33:14 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-hoqemax7wevu'
2026/11/05 04:33:14 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hoqemax7wevu': 1 files missing
2026/11/05 04:33:14 NOTICE: 1 hashes missing
2026/11/05 04:33:14 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hoqemax7wevu': 1 differences found
2026/11/05 04:33:14 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hoqemax7wevu': 2 errors while checking
both checkfile vs. NFDx2 remote (with normalization)
2026/11/05 04:33:15 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:33:15 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hoqemax7wevu': 0 differences found
2026/11/05 04:33:15 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hoqemax7wevu': 1 matching files
2026/11/05 04:33:15 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-hekaked9neja"
2026/11/05 04:33:15 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:33:15 DEBUG : Creating backend with remote "TestDrive:crypt/p48ais0r9tboohn2im52fipbsucv1b7a51q6qkg6r7e1a13ai7gg"
2026/11/05 04:33:16 DEBUG : Creating backend with remote "/tmp/rclone3430119868"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-hekaked9neja'", Local "Local file system at /tmp/rclone3430119868", Modify Window "1ms"
2026/11/05 04:33:19 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = ecaa5542917b67c13aba3cb5ec48bf27 OK
both checkfile vs. NFCx2 remote (without normalization)
2026/11/05 04:33:19 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/11/05 04:33:19 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-hekaked9neja'
2026/11/05 04:33:19 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hekaked9neja': 1 files missing
2026/11/05 04:33:19 NOTICE: 1 hashes missing
2026/11/05 04:33:19 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hekaked9neja': 1 differences found
2026/11/05 04:33:19 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hekaked9neja': 2 errors while checking
both checkfile vs. NFCx2 remote (with normalization)
2026/11/05 04:33:20 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/05 04:33:20 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hekaked9neja': 0 differences found
2026/11/05 04:33:20 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hekaked9neja': 1 matching files
2026/11/05 04:33:20 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-hekaked9neja': Purge remote
2026/11/05 04:33:20 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-hoqemax7wevu': Purge remote
2026/11/05 04:33:21 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-bezafoc6zido': Purge remote
2026/11/05 04:33:21 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-mecusaq9sumu': Purge remote
2026/11/05 04:33:22 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-narapoh7tove': Purge remote
2026/11/05 04:33:22 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-buvoxel9jama': Purge remote
2026/11/05 04:33:23 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-jacuzid7pavu': Purge remote
2026/11/05 04:33:23 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-rejinik2sobu': Purge remote
2026/11/05 04:33:24 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-lonobeh5vala': Purge remote
2026/11/05 04:33:24 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-koxuvoy3yada': Purge remote
--- PASS: TestApplyTransforms (49.97s)
=== RUN   TestTruncateString
--- PASS: TestTruncateString (0.00s)
=== RUN   TestCopyFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:33:25 DEBUG : file1: Need to transfer - File not found at Destination
2026/11/05 04:33:27 DEBUG : sub/file2: md5 = d9b8c253f123da530db7428bf987997a OK
2026/11/05 04:33:27 DEBUG : sub/file2: size = 14 OK
2026/11/05 04:33:27 INFO  : file1: Copied (new) to: sub/file2
2026/11/05 04:33:28 DEBUG : sub/file2: size = 14 OK
2026/11/05 04:33:28 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/05 04:33:28 DEBUG : file1: Unchanged skipping
2026/11/05 04:33:28 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': don't need to copy/move sub/file2, it is already at target location
--- PASS: TestCopyFile (5.77s)
=== RUN   TestCopyFileImmutable
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:33:31 DEBUG : existing: Need to transfer - File not found at Destination
2026/11/05 04:33:32 DEBUG : existing: md5 = 1d3b8b49edd2472fab85a3a3ed0848ee OK
2026/11/05 04:33:32 DEBUG : existing: size = 6 OK
2026/11/05 04:33:32 INFO  : existing: Copied (new)
2026/11/05 04:33:33 DEBUG : existing: size = 6 OK
2026/11/05 04:33:33 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/05 04:33:33 DEBUG : existing: Unchanged skipping
2026/11/05 04:33:33 DEBUG : existing: size = 8 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:33:33 DEBUG : existing: size = 6 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi')
2026/11/05 04:33:33 DEBUG : existing: Sizes differ
2026/11/05 04:33:33 ERROR : existing: Source and destination exist but do not match: immutable file modified
--- PASS: TestCopyFileImmutable (3.94s)
=== RUN   TestCopyLongFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
    copy_test.go:188: Test only runs on local
--- SKIP: TestCopyLongFile (0.41s)
=== RUN   TestCopyFileBackupDir
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:33:37 DEBUG : dst/file1: md5 = 7c35ecda59ea7bbaf00f1194af724c33 OK
2026/11/05 04:33:38 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/backup"
2026/11/05 04:33:38 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/1nrff024r7pq65ecp72fc28jb0"
2026/11/05 04:33:39 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:33:39 DEBUG : dst/file1: size = 18 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi')
2026/11/05 04:33:39 DEBUG : dst/file1: Sizes differ
2026/11/05 04:33:41 INFO  : dst/file1: Moved (server-side)
2026/11/05 04:33:42 DEBUG : dst/file1: md5 = 333f2f253d044f3b5a9c221c92bac76d OK
2026/11/05 04:33:42 DEBUG : dst/file1: size = 14 OK
2026/11/05 04:33:42 INFO  : dst/file1: Copied (new)
--- PASS: TestCopyFileBackupDir (12.27s)
=== RUN   TestCopyFileCompareDest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:33:47 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/dst"
2026/11/05 04:33:47 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/31u3jie661vd5p8j7rtc3hgbh0"
2026/11/05 04:33:49 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/CompareDest"
2026/11/05 04:33:49 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/gveqi14airsml4bgu7krj116o8"
2026/11/05 04:33:50 DEBUG : one: Need to transfer - File not found at Destination
2026/11/05 04:33:52 DEBUG : one: md5 = 1cadba3485517205f78c857ba5d50bab OK
2026/11/05 04:33:52 DEBUG : one: size = 3 OK
2026/11/05 04:33:52 INFO  : one: Copied (new)
2026/11/05 04:33:54 DEBUG : one: size = 5 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:33:54 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/dst')
2026/11/05 04:33:54 DEBUG : one: Sizes differ
2026/11/05 04:33:55 DEBUG : one: md5 = c30096f86b05b56836ce1d6fe512b70a OK
2026/11/05 04:33:55 DEBUG : one: size = 5 OK
2026/11/05 04:33:55 INFO  : one: Copied (replaced existing)
2026/11/05 04:33:58 DEBUG : dst/one: md5 = e8d7babb479169096c147148643fdd60 OK
2026/11/05 04:34:00 DEBUG : CompareDest/one: md5 = 46e285c2fa3dfdfd10ce116656ac4a48 OK
2026/11/05 04:34:01 DEBUG : one: size = 5 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:34:01 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/dst')
2026/11/05 04:34:01 DEBUG : one: Sizes differ
2026/11/05 04:34:01 DEBUG : one: size = 5 OK
2026/11/05 04:34:01 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/05 04:34:01 DEBUG : one: Destination found in --compare-dest, skipping
2026/11/05 04:34:03 DEBUG : CompareDest/two: md5 = aa3d493c3436f246bd93a427b44a7bb5 OK
2026/11/05 04:34:03 DEBUG : two: Need to transfer - File not found at Destination
2026/11/05 04:34:04 DEBUG : two: size = 3 OK
2026/11/05 04:34:04 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/05 04:34:04 DEBUG : two: Destination found in --compare-dest, skipping
2026/11/05 04:34:04 DEBUG : two: Need to transfer - File not found at Destination
2026/11/05 04:34:05 DEBUG : two: size = 3 OK
2026/11/05 04:34:05 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/05 04:34:05 DEBUG : two: Destination found in --compare-dest, skipping
2026/11/05 04:34:06 DEBUG : two: Need to transfer - File not found at Destination
2026/11/05 04:34:06 DEBUG : two: size = 5 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:34:06 DEBUG : two: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/CompareDest')
2026/11/05 04:34:06 DEBUG : two: Sizes differ
2026/11/05 04:34:07 DEBUG : two: md5 = 193d4a107ec5a6c667c4e1231e5afee4 OK
2026/11/05 04:34:07 DEBUG : two: size = 5 OK
2026/11/05 04:34:07 INFO  : two: Copied (new)
--- PASS: TestCopyFileCompareDest (24.93s)
=== RUN   TestCopyFileCopyDestImmutable
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:34:12 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/dst"
2026/11/05 04:34:12 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/31u3jie661vd5p8j7rtc3hgbh0"
2026/11/05 04:34:16 DEBUG : dst/one: md5 = dfdb94ca6a6e1d7996700e1565ea6e40 OK
2026/11/05 04:34:18 DEBUG : CopyDest/one: md5 = fbce2282819796a4d2297432665eb30a OK
2026/11/05 04:34:19 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/CopyDest"
2026/11/05 04:34:19 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/d09o6po3f7bm6ce32vdgs8h9ls"
2026/11/05 04:34:19 DEBUG : one: size = 5 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:34:19 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/dst')
2026/11/05 04:34:19 DEBUG : one: Sizes differ
2026/11/05 04:34:20 DEBUG : one: size = 5 OK
2026/11/05 04:34:20 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/05 04:34:20 DEBUG : one: size = 5 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:34:20 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/dst')
2026/11/05 04:34:20 DEBUG : one: Sizes differ
2026/11/05 04:34:20 ERROR : one: Source and destination exist but do not match: immutable file modified
--- PASS: TestCopyFileCopyDestImmutable (11.03s)
=== RUN   TestCopyFileCopyDest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:34:23 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/dst"
2026/11/05 04:34:23 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/31u3jie661vd5p8j7rtc3hgbh0"
2026/11/05 04:34:25 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/CopyDest"
2026/11/05 04:34:25 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/d09o6po3f7bm6ce32vdgs8h9ls"
2026/11/05 04:34:26 DEBUG : one: Need to transfer - File not found at Destination
2026/11/05 04:34:28 DEBUG : one: md5 = 0ddaf6ab6f0cf001d0d108db003eff88 OK
2026/11/05 04:34:28 DEBUG : one: size = 3 OK
2026/11/05 04:34:28 INFO  : one: Copied (new)
2026/11/05 04:34:30 DEBUG : one: size = 5 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:34:30 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/dst')
2026/11/05 04:34:30 DEBUG : one: Sizes differ
2026/11/05 04:34:31 DEBUG : one: md5 = 81ea523343e05c909abe6d84d23d72d2 OK
2026/11/05 04:34:31 DEBUG : one: size = 5 OK
2026/11/05 04:34:31 INFO  : one: Copied (replaced existing)
2026/11/05 04:34:33 DEBUG : dst/one: md5 = 50ec356fe29bdbb3820bb6f2906ea555 OK
2026/11/05 04:34:35 DEBUG : CopyDest/one: md5 = 68f9beb07a9bd128041553138b401dca OK
2026/11/05 04:34:36 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/BackupDir"
2026/11/05 04:34:36 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/s6dbk3lfi7c9kfvo6j7bla9m0g"
2026/11/05 04:34:37 DEBUG : one: size = 5 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:34:37 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/dst')
2026/11/05 04:34:37 DEBUG : one: Sizes differ
2026/11/05 04:34:38 DEBUG : one: size = 5 OK
2026/11/05 04:34:38 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/05 04:34:38 DEBUG : one: size = 5 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:34:38 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/dst')
2026/11/05 04:34:38 DEBUG : one: Sizes differ
2026/11/05 04:34:39 INFO  : one: Moved (server-side)
2026/11/05 04:34:40 DEBUG : one: size = 5 OK
2026/11/05 04:34:40 INFO  : one: Copied (server-side copy)
2026/11/05 04:34:40 DEBUG : one: Destination found in --copy-dest, using server-side copy
2026/11/05 04:34:42 DEBUG : CopyDest/two: md5 = 49978098d5f84afa23bdfa9712c604cd OK
2026/11/05 04:34:43 DEBUG : two: Need to transfer - File not found at Destination
2026/11/05 04:34:43 DEBUG : two: size = 3 OK
2026/11/05 04:34:43 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/05 04:34:44 DEBUG : two: size = 3 OK
2026/11/05 04:34:44 INFO  : two: Copied (server-side copy)
2026/11/05 04:34:44 DEBUG : two: Destination found in --copy-dest, using server-side copy
2026/11/05 04:34:45 DEBUG : two: size = 3 OK
2026/11/05 04:34:45 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/05 04:34:45 DEBUG : two: Unchanged skipping
2026/11/05 04:34:47 DEBUG : CopyDest/three: md5 = bdb26bbc3e778abe1795dbbbf7547f87 OK
2026/11/05 04:34:47 DEBUG : three: Need to transfer - File not found at Destination
2026/11/05 04:34:48 DEBUG : three: size = 7 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:34:48 DEBUG : three: size = 5 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi/CopyDest')
2026/11/05 04:34:48 DEBUG : three: Sizes differ
2026/11/05 04:34:48 DEBUG : three: Destination not found in --copy-dest
2026/11/05 04:34:49 DEBUG : three: md5 = 778adebbd709563d7c4bce8760107845 OK
2026/11/05 04:34:49 DEBUG : three: size = 7 OK
2026/11/05 04:34:49 INFO  : three: Copied (new)
--- PASS: TestCopyFileCopyDest (32.53s)
=== RUN   TestCopyInplace
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
    copy_test.go:434: Partial uploads not supported
--- SKIP: TestCopyInplace (0.41s)
=== RUN   TestCopyLongFileName
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
    copy_test.go:467: Partial uploads not supported
--- SKIP: TestCopyLongFileName (0.43s)
=== RUN   TestCopyLongFileNameCollision
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:34:57 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination
2026/11/05 04:34:59 DEBUG : TestCopyFileMaxTransfer/file1: md5 = 7e54df19181f9689dc5b160c19cd1499 OK
2026/11/05 04:34:59 DEBUG : TestCopyFileMaxTransfer/file1: size = 14 OK
2026/11/05 04:34:59 INFO  : TestCopyFileMaxTransfer/file1: Copied (new)
2026/11/05 04:35:00 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination
2026/11/05 04:35:00 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Post "https://www.googleapis.com/upload/drive/v3/files?alt=json&fields=id%2Cname%2Csize%2Cmd5Checksum%2Csha1Checksum%2Csha256Checksum%2Ctrashed%2CexplicitlyTrashed%2CmodifiedTime%2CcreatedTime%2CmimeType%2Cparents%2CwebViewLink%2CshortcutDetails%2CexportLinks%2CresourceKey&keepRevisionForever=false&prettyPrint=false&supportsAllDrives=true&uploadType=multipart": googleapi: Copy failed: max transfer limit reached as set by --max-transfer
    copy_test.go:563: Expecting error to contain accounting.ErrorMaxTransferLimitReachedFatal
2026/11/05 04:35:01 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination
2026/11/05 04:35:01 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination
2026/11/05 04:35:03 DEBUG : TestCopyFileMaxTransfer/file4: md5 = c49a1cdd7c30cd6f971d09a41dfdfbbe OK
2026/11/05 04:35:03 DEBUG : TestCopyFileMaxTransfer/file4: size = 2062 OK
2026/11/05 04:35:03 INFO  : TestCopyFileMaxTransfer/file4: Copied (new)
--- PASS: TestCopyFileMaxTransfer (8.59s)
=== RUN   TestDeduplicateInteractive
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
    dedupe_test.go:37: Can't run this test without a hash
--- SKIP: TestDeduplicateInteractive (0.46s)
=== RUN   TestDeduplicateSkip
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:35:08 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Looking for duplicate names using skip mode.
2026/11/05 04:35:09 NOTICE: one: Found 2 files with duplicate names
2026/11/05 04:35:09 NOTICE: one: Skipping 2 files with duplicate names
--- PASS: TestDeduplicateSkip (4.62s)
=== RUN   TestDeduplicateSizeOnly
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:35:14 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Looking for duplicate names using skip mode.
2026/11/05 04:35:15 NOTICE: one: Found 3 files with duplicate names
2026/11/05 04:35:15 NOTICE: one: Deleting 1/2 identical duplicates (size 11)
2026/11/05 04:35:15 INFO  : one: Deleted
2026/11/05 04:35:15 NOTICE: one: Skipping 2 files with duplicate names
--- PASS: TestDeduplicateSizeOnly (6.45s)
=== RUN   TestDeduplicateFirst
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:35:21 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Looking for duplicate names using first mode.
2026/11/05 04:35:21 NOTICE: one: Found 3 files with duplicate names
2026/11/05 04:35:22 INFO  : one: Deleted
2026/11/05 04:35:22 INFO  : one: Deleted
2026/11/05 04:35:22 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateFirst (6.18s)
=== RUN   TestDeduplicateNewest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:35:27 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Looking for duplicate names using newest mode.
2026/11/05 04:35:28 NOTICE: one: Found 3 files with duplicate names
2026/11/05 04:35:28 INFO  : one: Deleted
2026/11/05 04:35:28 INFO  : one: Deleted
2026/11/05 04:35:28 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateNewest (6.40s)
=== RUN   TestDeduplicateNewestByHash
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
    dedupe_test.go:37: Can't run this test without a hash
--- SKIP: TestDeduplicateNewestByHash (0.43s)
=== RUN   TestDeduplicateOldest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:35:34 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Looking for duplicate names using oldest mode.
2026/11/05 04:35:34 NOTICE: one: Found 3 files with duplicate names
2026/11/05 04:35:35 INFO  : one: Deleted
2026/11/05 04:35:35 INFO  : one: Deleted
2026/11/05 04:35:35 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateOldest (6.33s)
=== RUN   TestDeduplicateLargest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:35:40 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Looking for duplicate names using largest mode.
2026/11/05 04:35:41 NOTICE: one: Found 3 files with duplicate names
2026/11/05 04:35:41 INFO  : one: Deleted
2026/11/05 04:35:42 INFO  : one: Deleted
2026/11/05 04:35:42 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateLargest (6.68s)
=== RUN   TestDeduplicateSmallest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:35:47 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Looking for duplicate names using smallest mode.
2026/11/05 04:35:47 NOTICE: one: Found 3 files with duplicate names
2026/11/05 04:35:48 INFO  : one: Deleted
2026/11/05 04:35:48 INFO  : one: Deleted
2026/11/05 04:35:48 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateSmallest (6.47s)
=== RUN   TestDeduplicateRename
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:35:54 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Looking for duplicate names using rename mode.
2026/11/05 04:35:55 NOTICE: one.txt: Found 3 files with duplicate names
2026/11/05 04:35:55 INFO  : one-2.txt: renamed from: one.txt
2026/11/05 04:35:56 INFO  : one-3.txt: renamed from: one.txt
2026/11/05 04:35:57 INFO  : one-4.txt: renamed from: one.txt
--- PASS: TestDeduplicateRename (9.53s)
=== RUN   TestDeduplicateRenameManyExisting
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:36:00 DEBUG : one-1.txt: md5 = 25258d22196d5ec6da511de2f140fcfa OK
2026/11/05 04:36:02 DEBUG : one-2.txt: md5 = a35873754347358c8e56248c90089edf OK
2026/11/05 04:36:03 DEBUG : one-3.txt: md5 = 9911a0f55119dc9e2102c0463abed5c3 OK
2026/11/05 04:36:04 DEBUG : one-4.txt: md5 = 3f00268faf7270164c872cec146ff948 OK
2026/11/05 04:36:06 DEBUG : one-5.txt: md5 = 0cd9f3065d9f67987814867cb0ce74c0 OK
2026/11/05 04:36:07 DEBUG : one-6.txt: md5 = b80552d60490d964c7726c70cefafa92 OK
2026/11/05 04:36:09 DEBUG : one-7.txt: md5 = 7df9d1539a33d10b80aca8b1758cfc7b OK
2026/11/05 04:36:10 DEBUG : one-8.txt: md5 = bc8bdc825b3f9a8a5c81771983160c6a OK
2026/11/05 04:36:12 DEBUG : one-9.txt: md5 = 0e777c1edf3d85e97280789e4b6accb7 OK
2026/11/05 04:36:13 DEBUG : one-10.txt: md5 = e374d543e1085361bf86957e77d7f5df OK
2026/11/05 04:36:14 DEBUG : one-11.txt: md5 = 959a87b8fb6d13af01e085fbed5f0f32 OK
2026/11/05 04:36:16 DEBUG : one-12.txt: md5 = 29ed798ec54ab67fa6860bcc95c8175b OK
2026/11/05 04:36:17 DEBUG : one-13.txt: md5 = 31f38faac82d56281c1babfeb4e52815 OK
2026/11/05 04:36:19 DEBUG : one-14.txt: md5 = 99b7ee58501d655863d32947593aa1f6 OK
2026/11/05 04:36:20 DEBUG : one-15.txt: md5 = 613a40a0b423d3bfeba167fa328bae1e OK
2026/11/05 04:36:21 DEBUG : one-16.txt: md5 = 3b7f1987f07b2fc6847f1ec815fa1001 OK
2026/11/05 04:36:23 DEBUG : one-17.txt: md5 = f9c4931525590afa4ec61c32b1ed4a22 OK
2026/11/05 04:36:24 DEBUG : one-18.txt: md5 = 4641199ee129251909b31f3abb02edb7 OK
2026/11/05 04:36:26 DEBUG : one-19.txt: md5 = c3fe4152f50f752639b66eaedfc77737 OK
2026/11/05 04:36:27 DEBUG : one-20.txt: md5 = 5b821dd278274f5516fc51e5172231ea OK
2026/11/05 04:36:28 DEBUG : one-21.txt: md5 = d8ba0dce0509e09a4102ceb4a5d1c604 OK
2026/11/05 04:36:30 DEBUG : one-22.txt: md5 = f472e4bfcb061b8105b612adcc5e0ea3 OK
2026/11/05 04:36:31 DEBUG : one-23.txt: md5 = 7fd97358787c0cf824ebe6f0700b832a OK
2026/11/05 04:36:33 DEBUG : one-24.txt: md5 = 371c7f097f0b5a540cf30dc35df6377c OK
2026/11/05 04:36:34 DEBUG : one-25.txt: md5 = 463a93733d2bd33e7996241d1bfa1a3e OK
2026/11/05 04:36:36 DEBUG : one-26.txt: md5 = 1790c95386fb5969f63a7b73425b74d0 OK
2026/11/05 04:36:37 DEBUG : one-27.txt: md5 = 01759f692147eeafb175a08ec1ec5167 OK
2026/11/05 04:36:38 DEBUG : one-28.txt: md5 = 14f5ef58f18625af142981c763affb6f OK
2026/11/05 04:36:40 DEBUG : one-29.txt: md5 = 7d17cd4274b22032d91166e798ea776c OK
2026/11/05 04:36:41 DEBUG : one-30.txt: md5 = 6086b328d71e89f4ec0c684dac3646b4 OK
2026/11/05 04:36:43 DEBUG : one-31.txt: md5 = 68425b18ccc1e59192955d09558cb1a5 OK
2026/11/05 04:36:44 DEBUG : one-32.txt: md5 = 2ef1bb74719732a5b2b19803a02e7a0c OK
2026/11/05 04:36:46 DEBUG : one-33.txt: md5 = 99699ae8f6a13ec4cd804b24fd0bf064 OK
2026/11/05 04:36:47 DEBUG : one-34.txt: md5 = bae8ae5401f2b4d02cc2473b19082dca OK
2026/11/05 04:36:48 DEBUG : one-35.txt: md5 = 437b8636e716a815013dfcc92e76b68a OK
2026/11/05 04:36:50 DEBUG : one-36.txt: md5 = 00aee5b7661287c17833eedb8bdb43e3 OK
2026/11/05 04:36:51 DEBUG : one-37.txt: md5 = b36396f9e7228c6ed6f4303416de7c62 OK
2026/11/05 04:36:53 DEBUG : one-38.txt: md5 = 26caa3f09ad10eba1d63c0deb20c536d OK
2026/11/05 04:36:54 DEBUG : one-39.txt: md5 = 387c4361178428eae03c5244f9daa2af OK
2026/11/05 04:36:56 DEBUG : one-40.txt: md5 = 7f706dd3a200f71a5764cf732c03494d OK
2026/11/05 04:36:57 DEBUG : one-41.txt: md5 = d5577ecb170b7deec836a4f2432226c0 OK
2026/11/05 04:36:59 DEBUG : one-42.txt: md5 = afe36b170db49eda414a28b7cf586081 OK
2026/11/05 04:37:00 DEBUG : one-43.txt: md5 = c75670357fef6b9be5fb3fedd664acc7 OK
2026/11/05 04:37:01 DEBUG : one-44.txt: md5 = 4b8ca732f427aa3838b813c7ad212f17 OK
2026/11/05 04:37:03 DEBUG : one-45.txt: md5 = 767209978f0e4ce9014e31d11acb6dc8 OK
2026/11/05 04:37:04 DEBUG : one-46.txt: md5 = 91befff72565750036307f7eceb2c956 OK
2026/11/05 04:37:06 DEBUG : one-47.txt: md5 = 64d297b6a3c207067aedab3f894fdae7 OK
2026/11/05 04:37:07 DEBUG : one-48.txt: md5 = ad5d0de48b25b3f5dd4d18655a651551 OK
2026/11/05 04:37:08 DEBUG : one-49.txt: md5 = 51094b9e593abe811a11b110c0735ed6 OK
2026/11/05 04:37:10 DEBUG : one-50.txt: md5 = 19efeebc1a3a7345e0d2c37e1a3a03bf OK
2026/11/05 04:37:11 DEBUG : one-51.txt: md5 = aa8c3d5bd382ba8c3c0222de6d9c718a OK
2026/11/05 04:37:12 DEBUG : one-52.txt: md5 = d828b3019c4559eb5ac79bdde1e81dbd OK
2026/11/05 04:37:14 DEBUG : one-53.txt: md5 = b643107e9d1df3d4a803344335310ce3 OK
2026/11/05 04:37:15 DEBUG : one-54.txt: md5 = b26326d28d6b9592e6923670ba511876 OK
2026/11/05 04:37:17 DEBUG : one-55.txt: md5 = c5f584fd716b5dce7f2ccb486cac2279 OK
2026/11/05 04:37:18 DEBUG : one-56.txt: md5 = 1894797aadedefb6bd6dd5e044741a89 OK
2026/11/05 04:37:19 DEBUG : one-57.txt: md5 = be233f655931f694528b1c493c6a7f06 OK
2026/11/05 04:37:21 DEBUG : one-58.txt: md5 = a200d118170445326e23d58eb24ef001 OK
2026/11/05 04:37:22 DEBUG : one-59.txt: md5 = ecd421ca34031f2800774ba63ecc0a3a OK
2026/11/05 04:37:24 DEBUG : one-60.txt: md5 = 1fb5f6d0b0f0322cee8467e6730c488b OK
2026/11/05 04:37:25 DEBUG : one-61.txt: md5 = 14364f557f4abebc0557d2b23f4cc35f OK
2026/11/05 04:37:27 DEBUG : one-62.txt: md5 = 09c4fc86a5befa608666a1ca904c5924 OK
2026/11/05 04:37:28 DEBUG : one-63.txt: md5 = 517f64bd025a41347c09aed024af674d OK
2026/11/05 04:37:30 DEBUG : one-64.txt: md5 = c81e72c7e5cef1fb393b62ea32185b16 OK
2026/11/05 04:37:31 DEBUG : one-65.txt: md5 = e9f2cce3d867b5655f41c5a77f15b0c3 OK
2026/11/05 04:37:33 DEBUG : one-66.txt: md5 = 03af114288dbc9832b0e87871e44caf8 OK
2026/11/05 04:37:34 DEBUG : one-67.txt: md5 = e076ba058ddf883e5748fe05ce1f4910 OK
2026/11/05 04:37:35 DEBUG : one-68.txt: md5 = 4aa793f5868b4b1b2b162661604ab33b OK
2026/11/05 04:37:37 DEBUG : one-69.txt: md5 = 8bbbf5673609495585e3503784622730 OK
2026/11/05 04:37:38 DEBUG : one-70.txt: md5 = ad2e318de6761505999f2d3e3346b7ee OK
2026/11/05 04:37:40 DEBUG : one-71.txt: md5 = e3db0a75cbe141e4d8fb21a2702b9fa8 OK
2026/11/05 04:37:41 DEBUG : one-72.txt: md5 = 3c67721f3a4f6f7f5fdf66b8da4217ef OK
2026/11/05 04:37:42 DEBUG : one-73.txt: md5 = fab683883de06c73d85840e80cddb789 OK
2026/11/05 04:37:44 DEBUG : one-74.txt: md5 = 891f779150e6c406569181022ada3c03 OK
2026/11/05 04:37:45 DEBUG : one-75.txt: md5 = 009f7ee4200ec76edc5ad5029b36a335 OK
2026/11/05 04:37:47 DEBUG : one-76.txt: md5 = 1e7df2d7767fc17246d527475d039569 OK
2026/11/05 04:37:48 DEBUG : one-77.txt: md5 = 27811dba4b2f29cff66724454a584e49 OK
2026/11/05 04:37:50 DEBUG : one-78.txt: md5 = 7f9fe7aac626592f6a6ccfa7085239d8 OK
2026/11/05 04:37:51 DEBUG : one-79.txt: md5 = 84d2c3c6fc5b887f2eebeac1552bbb6c OK
2026/11/05 04:37:53 DEBUG : one-80.txt: md5 = 5fcded1721de3ed632da70e70cb7ab12 OK
2026/11/05 04:37:54 DEBUG : one-81.txt: md5 = 861fc82ec3ac1e66d8fcd302cbd94663 OK
2026/11/05 04:37:55 DEBUG : one-82.txt: md5 = 29f43500afc741ceb27cb632fced5c58 OK
2026/11/05 04:37:57 DEBUG : one-83.txt: md5 = aebe8e7401ef0cb66c685b10c20732c8 OK
2026/11/05 04:37:58 DEBUG : one-84.txt: md5 = 74c4cec91032c65754db42ac370a700a OK
2026/11/05 04:38:00 DEBUG : one-85.txt: md5 = 33b5d120b513a1d6fd6fceb8a8bd6b08 OK
2026/11/05 04:38:01 DEBUG : one-86.txt: md5 = 42daa44a4a15050ac1efe352be2aff02 OK
2026/11/05 04:38:03 DEBUG : one-87.txt: md5 = 411fd95a79718846b7349d4206246962 OK
2026/11/05 04:38:04 DEBUG : one-88.txt: md5 = 4c450315a05bac17cc79d1f5b7dbff4b OK
2026/11/05 04:38:06 DEBUG : one-89.txt: md5 = 01ff4ba43489c79d92a1a78488269739 OK
2026/11/05 04:38:07 DEBUG : one-90.txt: md5 = fe05d2b2791a68d82b1c1573a1cb1642 OK
2026/11/05 04:38:08 DEBUG : one-91.txt: md5 = da46a3795f2d257606716ac2f7ffff60 OK
2026/11/05 04:38:10 DEBUG : one-92.txt: md5 = f87846a8e8d266f781a436507039515a OK
2026/11/05 04:38:11 DEBUG : one-93.txt: md5 = 84360f330ba2cdb3a195701df3ed0cb7 OK
2026/11/05 04:38:13 DEBUG : one-94.txt: md5 = 392b419f6b695546ec16f0a73016b519 OK
2026/11/05 04:38:14 DEBUG : one-95.txt: md5 = 9222138204bc2bee55a767be308fa608 OK
2026/11/05 04:38:15 DEBUG : one-96.txt: md5 = 66d5b89f9bb92b5e3735303b1aa546ac OK
2026/11/05 04:38:17 DEBUG : one-97.txt: md5 = 0133c68ef82a46b357e2424260c5cb53 OK
2026/11/05 04:38:18 DEBUG : one-98.txt: md5 = 531702fbeab09c94bef5d41e961ed80e OK
2026/11/05 04:38:19 DEBUG : one-99.txt: md5 = 4df377ffdcba63abf38ec53e127beefa OK
2026/11/05 04:38:21 DEBUG : one-100.txt: md5 = a860edf96cb26ad2a0255e01d4f4319b OK
2026/11/05 04:38:22 DEBUG : one-101.txt: md5 = 54eea50cedbea16970d17620ecf468f1 OK
2026/11/05 04:38:24 DEBUG : one-102.txt: md5 = 5df799c750895d4f5c1cc61edbeed66c OK
2026/11/05 04:38:25 DEBUG : one-103.txt: md5 = 3a330689a85af82b7e650baf02ab4f51 OK
2026/11/05 04:38:26 DEBUG : one-104.txt: md5 = 95db57e730d32491c7d64c87338930fa OK
2026/11/05 04:38:28 DEBUG : one-105.txt: md5 = 50dfb25162c33bd5b92fe771992d36a4 OK
2026/11/05 04:38:31 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Looking for duplicate names using rename mode.
2026/11/05 04:38:31 NOTICE: one.txt: Found 2 files with duplicate names
2026/11/05 04:38:32 INFO  : one-106.txt: renamed from: one.txt
2026/11/05 04:38:33 INFO  : one-107.txt: renamed from: one.txt
--- PASS: TestDeduplicateRenameManyExisting (203.05s)
=== RUN   TestMergeDirs
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:39:24 DEBUG : dupe1/one.txt: md5 = 7db5bfbf6e241e58241858c5b49f8d04 OK
2026/11/05 04:39:26 DEBUG : dupe2/two.txt: md5 = aca93372372b83c3b6b2295937fe2647 OK
2026/11/05 04:39:28 DEBUG : dupe3/three.txt: md5 = a813add1b6860d045e1bf853bce2259d OK
2026/11/05 04:39:29 INFO  : urj8gsducqbtvekeq181ntd2u8: merging "sfrom47189m9qr3mt4qonu281c"
2026/11/05 04:39:29 INFO  : urj8gsducqbtvekeq181ntd2u8: removing empty directory
2026/11/05 04:39:30 INFO  : 1u1r4ei7c628fnjg9blqt3j60o: merging "tr2hj63d80ftlmvm6a952snjcc"
2026/11/05 04:39:31 INFO  : 1u1r4ei7c628fnjg9blqt3j60o: removing empty directory
--- PASS: TestMergeDirs (12.59s)
=== RUN   TestIndex
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:39:36 DEBUG : file1.txt: md5 = e9b69c13315b01a0210ff43c8c305731 OK
2026/11/05 04:39:38 DEBUG : sub/file2.txt: md5 = d87f3df3c8a2e83990ed849e92648ff3 OK
2026/11/05 04:39:41 DEBUG : sub/deep/file3.txt: md5 = 761d29f9997ae1794740a0dd2afadd3b OK
2026/11/05 04:39:43 DEBUG : index.html: md5 = ad23f3a262cb1a018b35e921c6b30807 OK
2026/11/05 04:39:43 DEBUG : index.html: size = 12147 OK
2026/11/05 04:39:43 INFO  : index.html: Copied (new)
2026/11/05 04:39:43 DEBUG : sub/deep/index.json: md5 = 6abfe59b641272a416bc38a3ccf95b97 OK
2026/11/05 04:39:43 DEBUG : sub/deep/index.json: size = 119 OK
2026/11/05 04:39:43 INFO  : sub/deep/index.json: Copied (new)
2026/11/05 04:39:43 DEBUG : sub/deep/index.html: md5 = da3f438796ae4a96e16f65eb91c6ba4c OK
2026/11/05 04:39:43 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/05 04:39:43 INFO  : sub/deep/index.html: Copied (new)
2026/11/05 04:39:43 DEBUG : sub/deep/caddy.json: md5 = 671b916a101413a4c922ff1ace7c440a OK
2026/11/05 04:39:43 DEBUG : sub/deep/caddy.json: size = 131 OK
2026/11/05 04:39:43 INFO  : sub/deep/caddy.json: Copied (new)
2026/11/05 04:39:44 DEBUG : index.json: md5 = e23b9805aa0d40faa99ff0e7ab3add40 OK
2026/11/05 04:39:44 DEBUG : index.json: size = 213 OK
2026/11/05 04:39:44 INFO  : index.json: Copied (new)
2026/11/05 04:39:44 DEBUG : caddy.json: md5 = 57718562e9317386a4ef36506b4aa85e OK
2026/11/05 04:39:44 DEBUG : caddy.json: size = 259 OK
2026/11/05 04:39:44 INFO  : caddy.json: Copied (new)
2026/11/05 04:39:44 DEBUG : sub/index.html: md5 = 6acfc00e9dc4f35131f9b944905fd920 OK
2026/11/05 04:39:44 DEBUG : sub/index.html: size = 12306 OK
2026/11/05 04:39:44 INFO  : sub/index.html: Copied (new)
2026/11/05 04:39:44 DEBUG : sub/index.json: md5 = f9dc95fad5a2b78bc60d374d5f785848 OK
2026/11/05 04:39:44 DEBUG : sub/index.json: size = 215 OK
2026/11/05 04:39:44 INFO  : sub/index.json: Copied (new)
2026/11/05 04:39:46 DEBUG : sub/caddy.json: md5 = 998f44e68245d636d7b0c4aefec71b4e OK
2026/11/05 04:39:46 DEBUG : sub/caddy.json: size = 261 OK
2026/11/05 04:39:46 INFO  : sub/caddy.json: Copied (new)
2026/11/05 04:39:51 DEBUG : sub/index.html: Unchanged skipping
2026/11/05 04:39:51 DEBUG : sub/deep/index.html: Unchanged skipping
2026/11/05 04:39:51 DEBUG : index.html: Unchanged skipping
2026/11/05 04:39:52 DEBUG : sub/index.json: Unchanged skipping
2026/11/05 04:39:52 DEBUG : sub/deep/index.json: Unchanged skipping
2026/11/05 04:39:52 DEBUG : index.json: Unchanged skipping
2026/11/05 04:39:53 DEBUG : caddy.json: Unchanged skipping
2026/11/05 04:39:53 DEBUG : sub/caddy.json: Unchanged skipping
2026/11/05 04:39:53 DEBUG : sub/deep/caddy.json: Unchanged skipping
2026/11/05 04:39:55 DEBUG : index.html: md5 = 5795b65762132f3e7859931b3d13dea1 OK
2026/11/05 04:39:55 DEBUG : index.html: size = 12147 OK
2026/11/05 04:39:55 INFO  : index.html: Copied (replaced existing)
2026/11/05 04:39:55 DEBUG : index.json: md5 = 201d5cd24f7d3c4c7eb8a3f9ee935521 OK
2026/11/05 04:39:55 DEBUG : index.json: size = 213 OK
2026/11/05 04:39:55 INFO  : index.json: Copied (replaced existing)
2026/11/05 04:39:55 DEBUG : sub/deep/index.html: md5 = d2fe3478bac59a7e61660fcd405ea76c OK
2026/11/05 04:39:55 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/05 04:39:55 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/11/05 04:39:55 DEBUG : caddy.json: md5 = 48f7c1f913079d64a3c0fe50a6a95301 OK
2026/11/05 04:39:55 DEBUG : caddy.json: size = 259 OK
2026/11/05 04:39:55 INFO  : caddy.json: Copied (replaced existing)
2026/11/05 04:39:56 DEBUG : sub/index.json: md5 = 740f57ae45cf80662ad8823ce4f90221 OK
2026/11/05 04:39:56 DEBUG : sub/index.json: size = 215 OK
2026/11/05 04:39:56 INFO  : sub/index.json: Copied (replaced existing)
2026/11/05 04:39:56 DEBUG : sub/index.html: md5 = 2f2a4db9815f61bccdaa6d7bdd6c5a55 OK
2026/11/05 04:39:56 DEBUG : sub/index.html: size = 12306 OK
2026/11/05 04:39:56 INFO  : sub/index.html: Copied (replaced existing)
2026/11/05 04:39:56 DEBUG : sub/deep/index.json: md5 = 8cfed3ddc0373458c51d2c9a471f3fff OK
2026/11/05 04:39:56 DEBUG : sub/deep/index.json: size = 119 OK
2026/11/05 04:39:56 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/11/05 04:39:56 DEBUG : sub/deep/caddy.json: md5 = 71af43b7cccded0020c533014d1d5431 OK
2026/11/05 04:39:56 DEBUG : sub/deep/caddy.json: size = 131 OK
2026/11/05 04:39:56 INFO  : sub/deep/caddy.json: Copied (replaced existing)
2026/11/05 04:39:57 DEBUG : sub/caddy.json: md5 = 12ca14bb0f24b41e4943bf19029838d3 OK
2026/11/05 04:39:57 DEBUG : sub/caddy.json: size = 261 OK
2026/11/05 04:39:57 INFO  : sub/caddy.json: Copied (replaced existing)
2026/11/05 04:39:58 DEBUG : sub/deep/file4.txt: md5 = bebba5a9dd359d4099f5c42ff8ae452e OK
2026/11/05 04:40:00 DEBUG : sub/index.html: Unchanged skipping
2026/11/05 04:40:00 DEBUG : index.html: Unchanged skipping
2026/11/05 04:40:00 DEBUG : sub/deep/index.json: md5 = 5e8a8532131b2a9f46d5586754d1ff70 OK
2026/11/05 04:40:00 DEBUG : sub/deep/index.json: size = 235 OK
2026/11/05 04:40:00 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/11/05 04:40:00 DEBUG : sub/deep/index.html: md5 = e82bb36d334e1196c4373fcbdc9c5bf5 OK
2026/11/05 04:40:00 DEBUG : sub/deep/index.html: size = 12346 OK
2026/11/05 04:40:00 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/11/05 04:40:00 DEBUG : sub/deep/caddy.json: md5 = f1a850639a6ce894c16370101135d024 OK
2026/11/05 04:40:00 DEBUG : sub/deep/caddy.json: size = 260 OK
2026/11/05 04:40:00 INFO  : sub/deep/caddy.json: Copied (replaced existing)
2026/11/05 04:40:00 DEBUG : sub/index.json: Unchanged skipping
2026/11/05 04:40:01 DEBUG : index.json: Unchanged skipping
2026/11/05 04:40:01 DEBUG : sub/caddy.json: Unchanged skipping
2026/11/05 04:40:01 DEBUG : caddy.json: Unchanged skipping
2026/11/05 04:40:04 DEBUG : sub/deep/file5.txt: md5 = 490b9232f011037870f2ee0628063af3 OK
2026/11/05 04:40:04 NOTICE: sub/deep/caddy.json: Skipped copy as --dry-run is set (size 389)
2026/11/05 04:40:04 NOTICE: sub/deep/index.html: Skipped copy as --dry-run is set (size 12.309Ki)
2026/11/05 04:40:04 NOTICE: sub/deep/index.json: Skipped copy as --dry-run is set (size 351)
2026/11/05 04:40:05 DEBUG : index.html: Unchanged skipping
2026/11/05 04:40:05 DEBUG : sub/index.html: Unchanged skipping
2026/11/05 04:40:06 DEBUG : index.json: Unchanged skipping
2026/11/05 04:40:06 DEBUG : sub/index.json: Unchanged skipping
2026/11/05 04:40:06 DEBUG : caddy.json: Unchanged skipping
2026/11/05 04:40:06 DEBUG : sub/caddy.json: Unchanged skipping
--- PASS: TestIndex (41.44s)
=== RUN   TestIndexDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:40:17 DEBUG : file1.txt: md5 = bc711c199b949d397c5052a9cfa4243d OK
2026/11/05 04:40:20 DEBUG : sub/file2.txt: md5 = cb5d9db7f94c9799c8cfc6ff5c4bfdb3 OK
2026/11/05 04:40:22 DEBUG : sub/deep/file3.txt: md5 = 2f9336dcb7a5995b4fa9060119a708ab OK
2026/11/05 04:40:24 DEBUG : sub/index.html: md5 = a24be77df0b9e82ecc311acde34039e1 OK
2026/11/05 04:40:24 DEBUG : sub/index.html: size = 12306 OK
2026/11/05 04:40:24 INFO  : sub/index.html: Copied (new)
2026/11/05 04:40:24 DEBUG : index.html: md5 = e1a1a894564edf19981082cb545764f6 OK
2026/11/05 04:40:24 DEBUG : index.html: size = 12147 OK
2026/11/05 04:40:24 INFO  : index.html: Copied (new)
2026/11/05 04:40:24 DEBUG : sub/deep/index.html: md5 = f87632292151c653b5549eecc45a653c OK
2026/11/05 04:40:24 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/05 04:40:24 INFO  : sub/deep/index.html: Copied (new)
2026/11/05 04:40:26 DEBUG : index.html: Unchanged skipping
2026/11/05 04:40:27 DEBUG : sub/index.html: Unchanged skipping
2026/11/05 04:40:28 DEBUG : sub/deep/index.html: md5 = 207777b1a27e1d7a9aaf9e0c3635fb42 OK
2026/11/05 04:40:28 DEBUG : sub/deep/index.html: size = 11829 OK
2026/11/05 04:40:28 INFO  : sub/deep/index.html: Copied (replaced existing)
--- PASS: TestIndexDelete (18.88s)
=== RUN   TestIndexFilter
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:40:36 DEBUG : file1.txt: md5 = 2aed430b7f3b017c4174dc0572dd2c3a OK
2026/11/05 04:40:39 DEBUG : sub/file2.txt: md5 = 95c947477cac744b0746f251fea87218 OK
2026/11/05 04:40:41 DEBUG : sub/deep/file3.txt: md5 = 7141084546f45a12365cd98119b73ee6 OK
2026/11/05 04:40:42 DEBUG : sub/deep/index.html: md5 = 1f49cc53af1a2da561020402c17347da OK
2026/11/05 04:40:44 DEBUG : other/notes.md: md5 = 84a0246f6e1f313f42ef9ec635356e06 OK
2026/11/05 04:40:45 DEBUG : other/notes.md: Excluded (Path Filter)
2026/11/05 04:40:47 DEBUG : other/index.html: md5 = 32edcb0e680c5d0da17cb36d0b515f34 OK
2026/11/05 04:40:47 DEBUG : other/index.html: size = 11802 OK
2026/11/05 04:40:47 INFO  : other/index.html: Copied (new)
2026/11/05 04:40:47 DEBUG : index.html: md5 = 9fe2183edad235d5832777075bca57d1 OK
2026/11/05 04:40:47 DEBUG : index.html: size = 12399 OK
2026/11/05 04:40:47 INFO  : index.html: Copied (new)
2026/11/05 04:40:47 DEBUG : sub/index.html: md5 = 7c4c0565a4596b9549ffd976527d99fe OK
2026/11/05 04:40:47 DEBUG : sub/index.html: size = 12056 OK
2026/11/05 04:40:47 INFO  : sub/index.html: Copied (new)
2026/11/05 04:40:52 DEBUG : other/notes.md: Excluded (Path Filter)
2026/11/05 04:40:53 DEBUG : index.html: Unchanged skipping
2026/11/05 04:40:53 DEBUG : sub/index.html: Unchanged skipping
2026/11/05 04:40:53 DEBUG : other/index.html: Unchanged skipping
--- PASS: TestIndexFilter (24.36s)
=== RUN   TestIndexRules
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:41:01 DEBUG : file1.txt: md5 = ae80f319a5bbdfbd4494d320746bb08b OK
2026/11/05 04:41:03 DEBUG : sub/file2.txt: md5 = 87aad710b8ded2c9e2e4b4becdb139d7 OK
2026/11/05 04:41:05 DEBUG : sub/deep/file3.txt: md5 = 24489c3bf5e24b17406d9a2805623b65 OK
2026/11/05 04:41:07 DEBUG : sub/deep/index.html: md5 = b8afc4ec6f1a3855eb0ca80fb6f2b606 OK
2026/11/05 04:41:09 DEBUG : index.html: md5 = 0c59736fd26df39437495581951d4460 OK
2026/11/05 04:41:09 DEBUG : index.html: size = 12147 OK
2026/11/05 04:41:09 INFO  : index.html: Copied (new)
2026/11/05 04:41:09 DEBUG : sub/index.html: md5 = c1ac351846ffee7acb89b9b5958b2070 OK
2026/11/05 04:41:09 DEBUG : sub/index.html: size = 12306 OK
2026/11/05 04:41:09 INFO  : sub/index.html: Copied (new)
2026/11/05 04:41:13 DEBUG : sub/index.html: Unchanged skipping
2026/11/05 04:41:14 DEBUG : sub/deep/index.html: md5 = 07ad5713fba7282260f2e29bcb007606 OK
2026/11/05 04:41:14 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/05 04:41:14 INFO  : sub/deep/index.html: Copied (replaced existing)
--- PASS: TestIndexRules (21.00s)
=== RUN   TestIndexMaxDepth
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:41:22 DEBUG : file1.txt: md5 = 02a5a04f7ba449d57e26cc7506f2b490 OK
2026/11/05 04:41:24 DEBUG : sub/file2.txt: md5 = ab4df2ef52a2367e03fe6f78e2385bcc OK
2026/11/05 04:41:26 DEBUG : sub/deep/file3.txt: md5 = b7443de7c0c63bc4b39e44ed2a1fde64 OK
2026/11/05 04:41:28 DEBUG : index.html: md5 = 61220264e296d1508e53e172aabf687a OK
2026/11/05 04:41:28 DEBUG : index.html: size = 12147 OK
2026/11/05 04:41:28 INFO  : index.html: Copied (new)
--- PASS: TestIndexMaxDepth (13.91s)
=== RUN   TestIndexLinkIndex
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:41:36 DEBUG : file1.txt: md5 = a0da0bd4fb956e7136f1091bc2d40eb8 OK
2026/11/05 04:41:38 DEBUG : sub/file2.txt: md5 = b01aab8980c9679082882a26848a97b2 OK
2026/11/05 04:41:40 DEBUG : sub/deep/file3.txt: md5 = 3f58aa7dc64bcae229e7c418e1c3f3e2 OK
2026/11/05 04:41:42 DEBUG : index.html: md5 = 20c9655afea3b8ff9e4d1d545a3daba3 OK
2026/11/05 04:41:42 DEBUG : index.html: size = 12167 OK
2026/11/05 04:41:42 INFO  : index.html: Copied (new)
2026/11/05 04:41:42 DEBUG : sub/index.html: md5 = c36140f8274b5cc5d3a0aace9ccc7524 OK
2026/11/05 04:41:42 DEBUG : sub/index.html: size = 12347 OK
2026/11/05 04:41:42 INFO  : sub/index.html: Copied (new)
2026/11/05 04:41:42 DEBUG : sub/deep/index.html: md5 = 45b1aeef5a3bf9e1c4fb385417ed4abc OK
2026/11/05 04:41:42 DEBUG : sub/deep/index.html: size = 12128 OK
2026/11/05 04:41:42 INFO  : sub/deep/index.html: Copied (new)
--- PASS: TestIndexLinkIndex (15.09s)
=== RUN   TestIndexDirTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:41:51 DEBUG : file1.txt: md5 = 0f8d38b684067b3977f7a996458989b3 OK
2026/11/05 04:41:53 DEBUG : sub/file2.txt: md5 = 2f46aacfb7dd2a59d9b00226a7833429 OK
2026/11/05 04:41:55 DEBUG : sub/deep/file3.txt: md5 = c2e7b7aa40d9990fbbe5551bf118046c OK
2026/11/05 04:41:57 DEBUG : index.json: md5 = e5e5d07e25589820e905a1f35de70081 OK
2026/11/05 04:41:57 DEBUG : index.json: size = 257 OK
2026/11/05 04:41:57 INFO  : index.json: Copied (new)
2026/11/05 04:41:57 DEBUG : sub/index.json: md5 = 991681d3f920cbdbe5f66430d8c7f990 OK
2026/11/05 04:41:57 DEBUG : sub/index.json: size = 259 OK
2026/11/05 04:41:57 INFO  : sub/index.json: Copied (new)
2026/11/05 04:41:57 DEBUG : sub/deep/index.json: md5 = 875e51a0ce1ead0c71a98e733d7bfbd5 OK
2026/11/05 04:41:57 DEBUG : sub/deep/index.json: size = 139 OK
2026/11/05 04:41:57 INFO  : sub/deep/index.json: Copied (new)
2026/11/05 04:42:00 DEBUG : sub/deep/index.json: Unchanged skipping
2026/11/05 04:42:01 DEBUG : index.json: md5 = 61196a7b2340b5fbbe7f2d6df4a5219d OK
2026/11/05 04:42:01 DEBUG : index.json: size = 237 OK
2026/11/05 04:42:01 INFO  : index.json: Copied (replaced existing)
2026/11/05 04:42:01 DEBUG : sub/index.json: md5 = 7eb676551549b853e44b132625649ba3 OK
2026/11/05 04:42:01 DEBUG : sub/index.json: size = 239 OK
2026/11/05 04:42:01 INFO  : sub/index.json: Copied (replaced existing)
2026/11/05 04:42:04 DEBUG : index.json: md5 = 4edbbcdc96b8590ecc95afdfb266603d OK
2026/11/05 04:42:04 DEBUG : index.json: size = 213 OK
2026/11/05 04:42:04 INFO  : index.json: Copied (replaced existing)
2026/11/05 04:42:04 DEBUG : sub/index.json: md5 = 4e33d1dad55ee40f915f90578af93752 OK
2026/11/05 04:42:04 DEBUG : sub/index.json: size = 215 OK
2026/11/05 04:42:04 INFO  : sub/index.json: Copied (replaced existing)
2026/11/05 04:42:04 DEBUG : sub/deep/index.json: md5 = 4ea6dd097109e6dfbe862535e4932a09 OK
2026/11/05 04:42:04 DEBUG : sub/deep/index.json: size = 119 OK
2026/11/05 04:42:04 INFO  : sub/deep/index.json: Copied (replaced existing)
--- PASS: TestIndexDirTime (20.61s)
=== RUN   TestIndexTemplate
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:42:11 DEBUG : file1.txt: md5 = 336b666d52d4768be0d35b111148b022 OK
2026/11/05 04:42:14 DEBUG : sub/file2.txt: md5 = 9125bbbf378fd565894ecbef9f1f5d23 OK
2026/11/05 04:42:16 DEBUG : sub/deep/file3.txt: md5 = 5244440523a5af02801dda1fe470db94 OK
2026/11/05 04:42:18 DEBUG : sub/list.txt: md5 = 576f9e195380708328c700ec82f6b650 OK
2026/11/05 04:42:18 DEBUG : sub/list.txt: size = 64 OK
2026/11/05 04:42:18 INFO  : sub/list.txt: Copied (new)
2026/11/05 04:42:18 DEBUG : list.txt: md5 = 41fd87635a0b5007af387414dea3edf2 OK
2026/11/05 04:42:18 DEBUG : list.txt: size = 59 OK
2026/11/05 04:42:18 INFO  : list.txt: Copied (new)
2026/11/05 04:42:18 DEBUG : sub/deep/list.txt: md5 = 0726ec59fec741f206c34852f9c7632f OK
2026/11/05 04:42:18 DEBUG : sub/deep/list.txt: size = 47 OK
2026/11/05 04:42:18 INFO  : sub/deep/list.txt: Copied (new)
--- PASS: TestIndexTemplate (14.07s)
=== 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:42:25 DEBUG : file1.txt: md5 = 13786582992d33e0482a7cdc9431ab89 OK
2026/11/05 04:42:28 DEBUG : sub/file2.txt: md5 = 743cda041b82ba5b35160ebe917d070f OK
2026/11/05 04:42:30 DEBUG : sub/deep/file3.txt: md5 = 97427a1b50a40decd157113f4b68577a OK
2026/11/05 04:42:32 DEBUG : other/notes.md: md5 = 8ad0b6878e7cb416a058f5792bc27b8d OK
2026/11/05 04:42:34 DEBUG : sub/index.html: md5 = 6611c226f86169a0b5d106ab3bef1657 OK
2026/11/05 04:42:34 DEBUG : sub/index.html: size = 12306 OK
2026/11/05 04:42:34 INFO  : sub/index.html: Copied (new)
2026/11/05 04:42:34 DEBUG : other/index.html: md5 = cc7559d7695df4b9691564594bc3f0f5 OK
2026/11/05 04:42:34 DEBUG : other/index.html: size = 12058 OK
2026/11/05 04:42:34 INFO  : other/index.html: Copied (new)
2026/11/05 04:42:34 DEBUG : sub/deep/index.html: md5 = 0fd89f3a478c16cc36bdcbc32c6033f8 OK
2026/11/05 04:42:34 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/05 04:42:34 INFO  : sub/deep/index.html: Copied (new)
2026/11/05 04:42:34 DEBUG : index.html: md5 = 3c1ec82d34eb9bec01c312731d588f3c OK
2026/11/05 04:42:34 DEBUG : index.html: size = 12399 OK
2026/11/05 04:42:34 INFO  : index.html: Copied (new)
2026/11/05 04:42:35 DEBUG : sub/deep/file4.txt: md5 = c918034b3c3d5a36a5eff3bde29cea29 OK
2026/11/05 04:42:37 DEBUG : other/undeclared.txt: md5 = 64b03ad32fb804480daf39ea1e425019 OK
2026/11/05 04:42:37 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 3 directories and walking 0 changed directories
2026/11/05 04:42:38 DEBUG : sub/index.html: Unchanged skipping
2026/11/05 04:42:38 DEBUG : index.html: Unchanged skipping
2026/11/05 04:42:39 DEBUG : sub/deep/index.html: md5 = e4b7fa79596387ce28c5f871acc7a7d9 OK
2026/11/05 04:42:39 DEBUG : sub/deep/index.html: size = 12346 OK
2026/11/05 04:42:39 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/11/05 04:42:43 DEBUG : sub/new/file5.txt: md5 = 2499640910358cb1f1a02fd79482d9f6 OK
2026/11/05 04:42:43 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 3 directories and walking 0 changed directories
2026/11/05 04:42:44 DEBUG : index.html: Unchanged skipping
2026/11/05 04:42:45 DEBUG : sub/index.html: md5 = b5c7a12fbd349b06267b4b2296f58919 OK
2026/11/05 04:42:45 DEBUG : sub/index.html: size = 12554 OK
2026/11/05 04:42:45 INFO  : sub/index.html: Copied (replaced existing)
2026/11/05 04:42:45 DEBUG : sub/new/index.html: md5 = a94d36b727e5b10c65f4d7ef7fbb1d77 OK
2026/11/05 04:42:45 DEBUG : sub/new/index.html: size = 12085 OK
2026/11/05 04:42:45 INFO  : sub/new/index.html: Copied (new)
2026/11/05 04:42:48 DEBUG : other/undeclared0.txt: md5 = 339c8995f6a3071f834f8553eb851b5b OK
2026/11/05 04:42:48 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 1 directories and walking 1 changed directories
2026/11/05 04:42:49 DEBUG : index.html: Unchanged skipping
2026/11/05 04:42:50 DEBUG : other/index.html: md5 = 40f7026d035e409059a17120618e86b6 OK
2026/11/05 04:42:50 DEBUG : other/index.html: size = 12597 OK
2026/11/05 04:42:50 INFO  : other/index.html: Copied (replaced existing)
2026/11/05 04:42:52 DEBUG : other/undeclared1.txt: md5 = 05faab21d8e0cbfd12aed6a132133470 OK
2026/11/05 04:42:52 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 1 directories and walking 0 changed directories
2026/11/05 04:42:53 DEBUG : index.html: Unchanged skipping
2026/11/05 04:42:54 DEBUG : other/index.html: md5 = fcda6fb7df14a68624ef31e8b65e672a OK
2026/11/05 04:42:54 DEBUG : other/index.html: size = 12867 OK
2026/11/05 04:42:54 INFO  : other/index.html: Copied (replaced existing)
2026/11/05 04:42:56 DEBUG : sub/file6.txt: md5 = 071571ab12db41337df2146e641b5119 OK
2026/11/05 04:42:56 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Nothing changed so nothing to index
2026/11/05 04:42:57 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Root changed so doing a full index
2026/11/05 04:42:58 DEBUG : sub/new/index.html: Unchanged skipping
2026/11/05 04:42:58 DEBUG : index.html: Unchanged skipping
2026/11/05 04:42:58 DEBUG : other/index.html: Unchanged skipping
2026/11/05 04:42:58 DEBUG : sub/deep/index.html: Unchanged skipping
2026/11/05 04:42:59 DEBUG : sub/index.html: md5 = bfd96dfa614875489b1d807c71050fe3 OK
2026/11/05 04:42:59 DEBUG : sub/index.html: size = 12813 OK
2026/11/05 04:42:59 INFO  : sub/index.html: Copied (replaced existing)
2026/11/05 04:43:01 DEBUG : sub/file7.txt: md5 = 152400b0b88cd1091b47ad17a3a866d3 OK
2026/11/05 04:43:01 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index would list 2 directories, more than 1, so doing a full index
2026/11/05 04:43:02 DEBUG : sub/deep/index.html: Unchanged skipping
2026/11/05 04:43:03 DEBUG : other/index.html: Unchanged skipping
2026/11/05 04:43:03 DEBUG : sub/new/index.html: Unchanged skipping
2026/11/05 04:43:03 DEBUG : index.html: Unchanged skipping
2026/11/05 04:43:03 DEBUG : sub/index.html: md5 = 4bc817a81917ce2c5e87b6fc32bd6de8 OK
2026/11/05 04:43:03 DEBUG : sub/index.html: size = 13071 OK
2026/11/05 04:43:03 INFO  : sub/index.html: Copied (replaced existing)
2026/11/05 04:43:06 DEBUG : sub/deep/file8.txt: md5 = fe0362728d7db5bbd37c91093a70601a OK
2026/11/05 04:43:06 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 1 directories and walking 1 changed directories
2026/11/05 04:43:07 DEBUG : index.html: Unchanged skipping
2026/11/05 04:43:07 DEBUG : sub/new/index.html: Unchanged skipping
2026/11/05 04:43:07 DEBUG : sub/index.html: Unchanged skipping
2026/11/05 04:43:08 DEBUG : sub/deep/index.html: md5 = b8f0b1c622970e57da9e2372ccdceb65 OK
2026/11/05 04:43:08 DEBUG : sub/deep/index.html: size = 12604 OK
2026/11/05 04:43:08 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/11/05 04:43:10 DEBUG : sub/deep/file9.txt: md5 = 19fd187f495113ed58f47c69e3d378da OK
2026/11/05 04:43:12 DEBUG : sub/file10.txt: md5 = 381496c930e0f83b983922e9587972df OK
2026/11/05 04:43:12 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 2 directories and walking 0 changed directories
2026/11/05 04:43:13 DEBUG : index.html: Unchanged skipping
2026/11/05 04:43:13 DEBUG : sub/index.html: md5 = a3bf5deecdc58b71f9e9870a148048cc OK
2026/11/05 04:43:13 DEBUG : sub/index.html: size = 13331 OK
2026/11/05 04:43:13 INFO  : sub/index.html: Copied (replaced existing)
--- PASS: TestIndexChanged (63.97s)
=== RUN   TestIndexChangedDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:43:29 DEBUG : file1.txt: md5 = 3d913b664503c742d461fda7e26db257 OK
2026/11/05 04:43:32 DEBUG : sub/file2.txt: md5 = e9eb6730e62b6c8c1cfa4dbd94dd20d0 OK
2026/11/05 04:43:34 DEBUG : sub/deep/file3.txt: md5 = 16879429d4fa908f45c835fcf75b33ec OK
2026/11/05 04:43:36 DEBUG : sub/index.html: md5 = a28ae69440b16189a0c68b62e91d34cb OK
2026/11/05 04:43:36 DEBUG : sub/index.html: size = 12306 OK
2026/11/05 04:43:36 INFO  : sub/index.html: Copied (new)
2026/11/05 04:43:36 DEBUG : index.html: md5 = 991b74974b9ca2369600c4773b5ca8e3 OK
2026/11/05 04:43:36 DEBUG : index.html: size = 12147 OK
2026/11/05 04:43:36 INFO  : index.html: Copied (new)
2026/11/05 04:43:36 DEBUG : sub/deep/index.html: md5 = adea25745f8576295a150229354f4141 OK
2026/11/05 04:43:36 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/05 04:43:36 INFO  : sub/deep/index.html: Copied (new)
2026/11/05 04:43:37 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 3 directories and walking 0 changed directories
2026/11/05 04:43:38 DEBUG : index.html: Unchanged skipping
2026/11/05 04:43:38 DEBUG : sub/index.html: Unchanged skipping
2026/11/05 04:43:39 DEBUG : sub/deep/index.html: md5 = b74182845273d01066ee4aaf61587a66 OK
2026/11/05 04:43:39 DEBUG : sub/deep/index.html: size = 11829 OK
2026/11/05 04:43:39 INFO  : sub/deep/index.html: Copied (replaced existing)
--- PASS: TestIndexChangedDelete (16.09s)
=== RUN   TestIndexChangedFiles
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:43:45 DEBUG : file1.txt: md5 = 6d9262fb7226de9f03e33d9143c66914 OK
2026/11/05 04:43:48 DEBUG : sub/file2.txt: md5 = 7cf5e0bb25225f3461b63429507a0851 OK
2026/11/05 04:43:50 DEBUG : sub/deep/file3.txt: md5 = 6b8b67b25a9c1470c26ac0a1a98c7932 OK
2026/11/05 04:43:52 DEBUG : - odd/file.txt: md5 = 3a039b12dfa2175388e2efeb4de538b7 OK
2026/11/05 04:43:54 DEBUG : - odd/index.html: md5 = f2e394e9ae9f8c21e407db41068970c2 OK
2026/11/05 04:43:54 DEBUG : - odd/index.html: size = 12058 OK
2026/11/05 04:43:54 INFO  : - odd/index.html: Copied (new)
2026/11/05 04:43:54 DEBUG : sub/index.html: md5 = 35744f6d22e863e8b985b7399a8508ad OK
2026/11/05 04:43:54 DEBUG : sub/index.html: size = 12306 OK
2026/11/05 04:43:54 INFO  : sub/index.html: Copied (new)
2026/11/05 04:43:54 DEBUG : index.html: md5 = c01bc58134a4396089759bf613db51ae OK
2026/11/05 04:43:54 DEBUG : index.html: size = 12401 OK
2026/11/05 04:43:54 INFO  : index.html: Copied (new)
2026/11/05 04:43:54 DEBUG : sub/deep/index.html: md5 = d31f384a1c668ff30562152aff79c890 OK
2026/11/05 04:43:54 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/05 04:43:54 INFO  : sub/deep/index.html: Copied (new)
2026/11/05 04:43:56 DEBUG : - odd/file8.txt: md5 = 68cfae1bb20d0807e470cc857f2c60ea OK
2026/11/05 04:43:57 DEBUG : sub/file9.txt: md5 = e5f0c3176db3abdd47cc537318532f1d OK
2026/11/05 04:43:57 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 2 directories and walking 0 changed directories
2026/11/05 04:43:58 DEBUG : index.html: Unchanged skipping
2026/11/05 04:43:59 DEBUG : - odd/index.html: md5 = c6eb91500f6a6fc3000bdff0a1304dee OK
2026/11/05 04:43:59 DEBUG : - odd/index.html: size = 12316 OK
2026/11/05 04:43:59 INFO  : - odd/index.html: Copied (replaced existing)
2026/11/05 04:44:00 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 4 directories and walking 0 changed directories
2026/11/05 04:44:02 DEBUG : index.html: Unchanged skipping
2026/11/05 04:44:02 DEBUG : sub/deep/index.html: Unchanged skipping
2026/11/05 04:44:02 DEBUG : - odd/index.html: Unchanged skipping
2026/11/05 04:44:03 DEBUG : sub/index.html: md5 = a75b68ee01faeb342abc2d5b223066f1 OK
2026/11/05 04:44:03 DEBUG : sub/index.html: size = 12565 OK
2026/11/05 04:44:03 INFO  : sub/index.html: Copied (replaced existing)
--- PASS: TestIndexChangedFiles (26.98s)
=== RUN   TestIndexChangedDirTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:44:12 DEBUG : file1.txt: md5 = 69ffd8d6fffedc3b9badddf1dfd751bb OK
2026/11/05 04:44:15 DEBUG : sub/file2.txt: md5 = 596b81e673d82554850546e1c25417ed OK
2026/11/05 04:44:16 DEBUG : sub/deep/file3.txt: md5 = 751db81bf3c5c179b28679ebb6180755 OK
2026/11/05 04:44:19 DEBUG : other/notes.md: md5 = 1f6600e04c3fb95c02209013a0d2f948 OK
2026/11/05 04:44:21 DEBUG : index.json: md5 = 883983b696751526c697f95f1244e3a5 OK
2026/11/05 04:44:21 DEBUG : index.json: size = 379 OK
2026/11/05 04:44:21 INFO  : index.json: Copied (new)
2026/11/05 04:44:21 DEBUG : sub/deep/index.json: md5 = f6b00de1dedc37a253b9686a927cfb8e OK
2026/11/05 04:44:21 DEBUG : sub/deep/index.json: size = 139 OK
2026/11/05 04:44:21 INFO  : sub/deep/index.json: Copied (new)
2026/11/05 04:44:21 DEBUG : sub/index.json: md5 = 3e0631cf850ad9a8e4de60a3f1c1320b OK
2026/11/05 04:44:21 DEBUG : sub/index.json: size = 259 OK
2026/11/05 04:44:21 INFO  : sub/index.json: Copied (new)
2026/11/05 04:44:21 DEBUG : other/index.json: md5 = 182e9324be16c2a7792fc3ed49536d9a OK
2026/11/05 04:44:21 DEBUG : other/index.json: size = 144 OK
2026/11/05 04:44:21 INFO  : other/index.json: Copied (new)
2026/11/05 04:44:22 DEBUG : sub/deep/file4.txt: md5 = c6761de0009bb65984091daa14f66d39 OK
2026/11/05 04:44:22 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Partial index: listing 3 directories and walking 0 changed directories
2026/11/05 04:44:25 DEBUG : sub/deep/index.json: md5 = 24a5b9024e72918a010db51590b38560 OK
2026/11/05 04:44:25 DEBUG : sub/deep/index.json: size = 275 OK
2026/11/05 04:44:25 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/11/05 04:44:25 DEBUG : sub/index.json: md5 = 777bf63665c701dac5dd5274df7e84d4 OK
2026/11/05 04:44:25 DEBUG : sub/index.json: size = 259 OK
2026/11/05 04:44:25 INFO  : sub/index.json: Copied (replaced existing)
2026/11/05 04:44:25 DEBUG : index.json: md5 = 7543bc57ad5d99554973e9bd0886044a OK
2026/11/05 04:44:25 DEBUG : index.json: size = 379 OK
2026/11/05 04:44:25 INFO  : index.json: Copied (replaced existing)
--- PASS: TestIndexChangedDirTime (22.12s)
=== RUN   TestListDirSorted
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:44:35 DEBUG : a.txt: md5 = 75613b2040fab01057788bbe28213094 OK
2026/11/05 04:44:36 DEBUG : zend.txt: md5 = 2408cc3082afd1f9a3d7d6357441a386 OK
2026/11/05 04:44:38 DEBUG : sub dir/hello world: md5 = f122202ac625a6f833c50a17eec1f5c8 OK
2026/11/05 04:44:39 DEBUG : sub dir/hello world2: md5 = d70faf78f79fedc3393ea6847eee6bdc OK
2026/11/05 04:44:42 DEBUG : sub dir/ignore dir/.ignore: md5 = f6c1ddc63ca01dc027051b9863cfd69d OK
2026/11/05 04:44:43 DEBUG : sub dir/ignore dir/should be ignored: md5 = b6141b43ccdd8b0f4114bb125232a384 OK
2026/11/05 04:44:45 DEBUG : sub dir/sub sub dir/hello world3: md5 = 9172bc2aaebe54042140dc4dbf03339d OK
2026/11/05 04:44:46 DEBUG : a.txt: Excluded (Size Filter)
2026/11/05 04:44:46 DEBUG : a.txt: Excluded
2026/11/05 04:44:47 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/11/05 04:44:47 DEBUG : sub dir/hello world2: Excluded
2026/11/05 04:44:47 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/11/05 04:44:47 DEBUG : sub dir/hello world: Excluded
2026/11/05 04:44:47 DEBUG : sub dir/ignore dir: Excluded
2026/11/05 04:44:47 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/11/05 04:44:47 DEBUG : sub dir/hello world2: Excluded
2026/11/05 04:44:47 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/11/05 04:44:47 DEBUG : sub dir/hello world: Excluded
2026/11/05 04:44:48 DEBUG : sub dir/ignore dir: Excluded
--- PASS: TestListDirSorted (20.77s)
=== RUN   TestListDirSortedFn
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:44:55 DEBUG : a.txt: md5 = 9b56aca17113aeec408b7bda1e1288d8 OK
2026/11/05 04:44:57 DEBUG : zend.txt: md5 = 8b11e9d8a32f4bff4ae653a0e4f3ce1f OK
2026/11/05 04:44:59 DEBUG : sub dir/hello world: md5 = b64ada8b7feb080a9390f0d8e45c25eb OK
2026/11/05 04:45:00 DEBUG : sub dir/hello world2: md5 = 90c867d37d1642328e7fdfea68c13827 OK
2026/11/05 04:45:03 DEBUG : sub dir/ignore dir/.ignore: md5 = 81c696268fbfd12f6cbcece9d951b4e8 OK
2026/11/05 04:45:04 DEBUG : sub dir/ignore dir/should be ignored: md5 = 60f34de04503a4aea47392cea7ad8202 OK
2026/11/05 04:45:06 DEBUG : sub dir/sub sub dir/hello world3: md5 = 9df62a9a96db90760948843dde586a63 OK
2026/11/05 04:45:07 DEBUG : a.txt: Excluded (Size Filter)
2026/11/05 04:45:07 DEBUG : a.txt: Excluded
2026/11/05 04:45:08 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/11/05 04:45:08 DEBUG : sub dir/hello world: Excluded
2026/11/05 04:45:08 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/11/05 04:45:08 DEBUG : sub dir/hello world2: Excluded
2026/11/05 04:45:09 DEBUG : sub dir/ignore dir: Excluded
2026/11/05 04:45:09 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/11/05 04:45:09 DEBUG : sub dir/hello world: Excluded
2026/11/05 04:45:09 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/11/05 04:45:09 DEBUG : sub dir/hello world2: Excluded
2026/11/05 04:45:09 DEBUG : sub dir/ignore dir: Excluded
--- PASS: TestListDirSortedFn (21.79s)
=== RUN   TestListJSON
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:45:17 DEBUG : file1: md5 = ad1b613f6b0d8f5ed41834400a332078 OK
2026/11/05 04:45:19 DEBUG : sub/file2: md5 = beac5ce63ec21813156784dd66b39707 OK
=== RUN   TestListJSON/Default
=== RUN   TestListJSON/FilesOnly
=== RUN   TestListJSON/DirsOnly
=== RUN   TestListJSON/Recurse
=== RUN   TestListJSON/SubDir
=== RUN   TestListJSON/NoModTime
=== RUN   TestListJSON/NoMimeType
=== RUN   TestListJSON/ShowHash
=== RUN   TestListJSON/HashTypes
2026/11/05 04:45:23 ERROR : file1: Failed to read hash: hash type not supported
=== RUN   TestListJSON/Metadata
2026/11/05 04:45:23 DEBUG : eer8kka55qnghc34cq76ca668g: Fetching metadata
2026/11/05 04:45:23 DEBUG : 150fuo3cn4j1uenq6r4g4qk6t4: Fetching metadata
--- PASS: TestListJSON (9.73s)
    --- PASS: TestListJSON/Default (0.23s)
    --- PASS: TestListJSON/FilesOnly (0.36s)
    --- PASS: TestListJSON/DirsOnly (0.28s)
    --- PASS: TestListJSON/Recurse (0.60s)
    --- PASS: TestListJSON/SubDir (0.23s)
    --- PASS: TestListJSON/NoModTime (0.26s)
    --- PASS: TestListJSON/NoMimeType (0.24s)
    --- PASS: TestListJSON/ShowHash (0.24s)
    --- PASS: TestListJSON/HashTypes (0.28s)
    --- PASS: TestListJSON/Metadata (0.68s)
=== RUN   TestStatJSON
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:45:27 DEBUG : file1: md5 = db01ae875247749272d041d50a8566aa OK
2026/11/05 04:45:29 DEBUG : sub/file2: md5 = 6d61bae6dab68439bbceef1c639b1301 OK
=== RUN   TestStatJSON/Root
=== RUN   TestStatJSON/RootFilesOnly
=== RUN   TestStatJSON/RootDirsOnly
=== RUN   TestStatJSON/Dir
=== RUN   TestStatJSON/DirWithTrailingSlash
=== RUN   TestStatJSON/File
=== RUN   TestStatJSON/NotFound
=== RUN   TestStatJSON/DirFilesOnly
=== RUN   TestStatJSON/FileFilesOnly
=== RUN   TestStatJSON/NotFoundFilesOnly
=== RUN   TestStatJSON/DirDirsOnly
=== RUN   TestStatJSON/FileDirsOnly
=== RUN   TestStatJSON/NotFoundDirsOnly
=== RUN   TestStatJSON/RootNotFound
2026/11/05 04:45:33 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/notfound"
2026/11/05 04:45:33 DEBUG : Config file has changed externally - reloading
2026/11/05 04:45:33 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/qe0i31qdkoejk60elps0ni5sqk"
--- PASS: TestStatJSON (13.12s)
    --- PASS: TestStatJSON/Root (0.23s)
    --- PASS: TestStatJSON/RootFilesOnly (0.00s)
    --- PASS: TestStatJSON/RootDirsOnly (0.25s)
    --- PASS: TestStatJSON/Dir (0.56s)
    --- PASS: TestStatJSON/DirWithTrailingSlash (0.25s)
    --- PASS: TestStatJSON/File (0.23s)
    --- PASS: TestStatJSON/NotFound (0.43s)
    --- PASS: TestStatJSON/DirFilesOnly (0.27s)
    --- PASS: TestStatJSON/FileFilesOnly (0.22s)
    --- PASS: TestStatJSON/NotFoundFilesOnly (0.20s)
    --- PASS: TestStatJSON/DirDirsOnly (0.22s)
    --- PASS: TestStatJSON/FileDirsOnly (0.31s)
    --- PASS: TestStatJSON/NotFoundDirsOnly (0.27s)
    --- PASS: TestStatJSON/RootNotFound (1.72s)
=== RUN   TestStatJSONMemory
2026/11/05 04:45:39 DEBUG : Creating backend with remote ":memory:"
2026/11/05 04:45:39 DEBUG : Memory root '': File to upload is small (5 bytes), uploading instead of streaming
2026/11/05 04:45:39 DEBUG : sub/file1: size = 5 OK
2026/11/05 04:45:39 DEBUG : sub/file1: md5 = 5d41402abc4b2a76b9719d911017c592 OK
2026/11/05 04:45:39 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:45:39 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Making directory
2026/11/05 04:45:39 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Making directory
--- PASS: TestMkdir (0.79s)
=== RUN   TestLsd
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:45:42 DEBUG : sub dir/hello world: md5 = f853c8f7c9c4dc409451305d5e09c03f OK
--- PASS: TestLsd (4.82s)
=== RUN   TestLs
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:45:46 DEBUG : potato2: md5 = 839904099f97ef6820dcf89ee030c874 OK
2026/11/05 04:45:47 DEBUG : empty space: md5 = fbecbe1c71c4dead1ed2cf61384fe774 OK
--- PASS: TestLs (4.76s)
=== RUN   TestLsWithFilesFrom
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:45:50 DEBUG : potato2: md5 = 53f260027350774a2ec5103de65d63f3 OK
2026/11/05 04:45:52 DEBUG : empty space: md5 = 856746c558ff959fc698bdb1bdbed6f3 OK
2026/11/05 04:45:52 DEBUG : empty space: Excluded (FilesFrom Filter)
2026/11/05 04:45:52 DEBUG : empty space: Excluded
--- PASS: TestLsWithFilesFrom (7.26s)
=== RUN   TestLsLong
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:45:58 DEBUG : potato2: md5 = 4029b29eee52c62293ead21c6f9d42e1 OK
2026/11/05 04:46:00 DEBUG : empty space: md5 = 8638350f42f2d49386c9ec687bbe24ec OK
--- PASS: TestLsLong (5.47s)
=== RUN   TestHashSums
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:46:03 DEBUG : potato2: md5 = 15adef610c2d158d78a7f2f3c16a4cdb OK
2026/11/05 04:46:05 DEBUG : empty space: md5 = eca2d0828a3549d4fbbcd34cdf854fd0 OK
--- PASS: TestHashSums (4.62s)
=== RUN   TestHashSumsWithErrors
2026/11/05 04:46:06 DEBUG : Creating backend with remote ":memory:"
2026/11/05 04:46:06 ERROR : file1: hash unsupported: hash type not supported
2026/11/05 04:46:06 ERROR : sub/file1: hash unsupported: hash type not supported
2026/11/05 04:46:06 ERROR : sub/file1: hash unsupported: hash type not supported
--- PASS: TestHashSumsWithErrors (0.00s)
=== RUN   TestHashStream
2026/11/05 04:46:06 DEBUG : Creating md5 hash of 0 bytes read from input stream
2026/11/05 04:46:06 DEBUG : Creating md5 hash of 0 bytes read from input stream
2026/11/05 04:46:06 DEBUG : Creating sha1 hash of 0 bytes read from input stream
2026/11/05 04:46:06 DEBUG : Creating sha1 hash of 0 bytes read from input stream
2026/11/05 04:46:06 DEBUG : Creating md5 hash of 12 bytes read from input stream
2026/11/05 04:46:06 DEBUG : Creating md5 hash of 12 bytes read from input stream
2026/11/05 04:46:06 DEBUG : Creating sha1 hash of 12 bytes read from input stream
2026/11/05 04:46:06 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:46:08 DEBUG : potato2: md5 = a35e61f4b2be2a674ab442dbf2994c3c OK
2026/11/05 04:46:09 DEBUG : empty space: md5 = da5f0b5483b5b1231db265cbcf04652a OK
2026/11/05 04:46:11 DEBUG : sub dir/potato3: md5 = 300337fbe19ef6e895c22027609838f3 OK
--- PASS: TestCount (8.50s)
=== RUN   TestDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:46:16 DEBUG : small: md5 = 0807d9ef845c0b34ac1b3ecf9302cc27 OK
2026/11/05 04:46:18 DEBUG : medium: md5 = 97925f3418769a378070e7729471bd6f OK
2026/11/05 04:46:19 DEBUG : large: md5 = e44aeb8dbbe38b3a567d84d881c9ade5 OK
2026/11/05 04:46:19 DEBUG : Waiting for deletions to finish
2026/11/05 04:46:20 DEBUG : large: Excluded (Size Filter)
2026/11/05 04:46:20 INFO  : small: Deleted
2026/11/05 04:46:20 INFO  : medium: Deleted
--- PASS: TestDelete (6.33s)
=== RUN   TestDeleteFatalError
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:46:23 DEBUG : file0: md5 = 8811a738282afd6dda2d164af6bd4cf2 OK
2026/11/05 04:46:24 DEBUG : file1: md5 = bd6d7a1cf2a2cf251879a6285f9984d1 OK
2026/11/05 04:46:25 DEBUG : file2: md5 = 22c477b02f92e8ef080b98ab62430dda OK
2026/11/05 04:46:27 DEBUG : file3: md5 = 28d7f8426f200dbdfb44ab8a7f11031a OK
2026/11/05 04:46:28 DEBUG : file4: md5 = d39d37c6ecae90ec4cff6c7bdc1d5e2b OK
2026/11/05 04:46:30 DEBUG : file5: md5 = 9b0b5278921cb1734500eb687e6aa92f OK
2026/11/05 04:46:31 DEBUG : file6: md5 = 55f6c9bda3a98cd54d32e7d4f7114bf9 OK
2026/11/05 04:46:33 DEBUG : file7: md5 = 65dde53c2bd502ad222bf5ef3cecc3dc OK
2026/11/05 04:46:34 DEBUG : file8: md5 = 4fd91a35a2b2d3fa92311b6c254eccd4 OK
2026/11/05 04:46:35 DEBUG : file9: md5 = 7d21f548d231cff1405ca63a5621caf4 OK
2026/11/05 04:46:37 DEBUG : file10: md5 = eae502a6b52aa4d08803f29d7ba10e1c OK
2026/11/05 04:46:38 DEBUG : file11: md5 = 09c94e22272bb73c1272ab460c635111 OK
2026/11/05 04:46:39 DEBUG : file12: md5 = a1b4e7b3086597b3c26ae7508eb709a5 OK
2026/11/05 04:46:41 DEBUG : file13: md5 = cf5357b937196df9e85ab16848b24b6b OK
2026/11/05 04:46:42 DEBUG : file14: md5 = 391ff83131cbee7c58f9b9137ee83ce2 OK
2026/11/05 04:46:44 DEBUG : file15: md5 = 18098bb05e9663878c2cad2d62f96700 OK
2026/11/05 04:46:45 DEBUG : file16: md5 = 62b69f33eff10071766bfcd9271d622d OK
2026/11/05 04:46:46 DEBUG : file17: md5 = f1d4d6d2b40cf0b96ff57ddbf2eae45a OK
2026/11/05 04:46:48 DEBUG : file18: md5 = 1d48977555f6371c8a444aa150c4b742 OK
2026/11/05 04:46:49 DEBUG : file19: md5 = 102b8248abefd5fb27b267dc4626e670 OK
2026/11/05 04:46:49 DEBUG : Waiting for deletions to finish
2026/11/05 04:46:50 ERROR : file13: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file12: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file6: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file14: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file3: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file9: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file11: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file18: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file2: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file15: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file8: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file7: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file10: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file16: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file5: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file17: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file1: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file4: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file19: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:46:50 ERROR : file0: Got fatal error on delete: --max-delete threshold reached
--- PASS: TestDeleteFatalError (37.67s)
=== RUN   TestMaxDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:47:00 DEBUG : small: md5 = beba8c89929a3541cd02ad93ce242db8 OK
2026/11/05 04:47:01 DEBUG : medium: md5 = 13fdaede626856379bef585b840bc939 OK
2026/11/05 04:47:03 DEBUG : large: md5 = c2190da80bf3b93178757ae79b2204c7 OK
2026/11/05 04:47:03 DEBUG : Waiting for deletions to finish
2026/11/05 04:47:03 ERROR : medium: Got fatal error on delete: --max-delete threshold reached
2026/11/05 04:47:04 INFO  : small: Deleted
2026/11/05 04:47:04 INFO  : large: Deleted
--- PASS: TestMaxDelete (6.48s)
=== RUN   TestMaxDeleteSizeLargeFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:47:07 DEBUG : small: md5 = 271b0c70600349a18bd3903fb5aeb1c3 OK
2026/11/05 04:47:08 DEBUG : medium: md5 = 2a4880720f80732756e3e99116e074ed OK
2026/11/05 04:47:10 DEBUG : large: md5 = 1ca4461e71591c9ac96b70982f901ba0 OK
2026/11/05 04:47:10 DEBUG : Waiting for deletions to finish
2026/11/05 04:47:10 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached
2026/11/05 04:47:11 INFO  : small: Deleted
2026/11/05 04:47:11 INFO  : medium: Deleted
--- PASS: TestMaxDeleteSizeLargeFile (6.90s)
=== RUN   TestMaxDeleteSize
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:47:14 DEBUG : small: md5 = ec56d98e11284b14d8c20395b463bbfa OK
2026/11/05 04:47:15 DEBUG : medium: md5 = b1b6ce290f85e2796863b75374f55e5d OK
2026/11/05 04:47:17 DEBUG : large: md5 = ea18a621fedb3dd5dba3d90ae31b196b OK
2026/11/05 04:47:17 DEBUG : Waiting for deletions to finish
2026/11/05 04:47:17 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached
2026/11/05 04:47:18 INFO  : medium: Deleted
2026/11/05 04:47:18 INFO  : small: Deleted
--- PASS: TestMaxDeleteSize (6.92s)
=== RUN   TestReadFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:47:21 DEBUG : ReadFile: md5 = 2d4c1f2c2bdb34897af27b223e4d6fdd OK
--- PASS: TestReadFile (3.97s)
=== RUN   TestRetry
2026/11/05 04:47:23 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 1/5
2026/11/05 04:47:23 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 2/5
2026/11/05 04:47:23 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
2026/11/05 04:47:23 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
2026/11/05 04:47:23 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
2026/11/05 04:47:23 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
--- PASS: TestRetry (0.04s)
=== RUN   TestRetryAfterContextCancel
2026/11/05 04:47:23 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:47:25 DEBUG : file1: md5 = 31f7e5ba371b2eccc40aa23e55c045a1 OK
2026/11/05 04:47:26 DEBUG : file2: md5 = 8c8ce2bc3b2c5a432ea7e1582535d585 OK
--- PASS: TestCat (15.86s)
=== RUN   TestPurge
2026/11/05 04:47:39 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-sififum4duta"
2026/11/05 04:47:39 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:47:39 DEBUG : Creating backend with remote "TestDrive:crypt/sbi4tmupjq55d5o1cofjepm2f4gm3qjlgi5l0qfsaspufaumjut0"
2026/11/05 04:47:40 DEBUG : Creating backend with remote "/tmp/rclone3626898345"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-sififum4duta'", Local "Local file system at /tmp/rclone3626898345", Modify Window "1ms"
2026/11/05 04:47:44 DEBUG : A1/B1/C1/one: md5 = 5bf3701857ac54ef7bc8197a043b2967 OK
2026/11/05 04:47:44 INFO  : A2: Making directory
2026/11/05 04:47:45 INFO  : A1/B2: Making directory
2026/11/05 04:47:46 INFO  : A1/B2/C2: Making directory
2026/11/05 04:47:46 INFO  : A1/B1/C3: Making directory
2026/11/05 04:47:47 INFO  : A3: Making directory
2026/11/05 04:47:48 INFO  : A3/B3: Making directory
2026/11/05 04:47:49 INFO  : A3/B3/C4: Making directory
2026/11/05 04:47:51 DEBUG : A1/two: md5 = 0b6ede246b1eebc0f7e6074e0236539b OK
2026/11/05 04:47:55 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-sififum4duta': Purge remote
2026/11/05 04:47:55 NOTICE: purge failed: directory not found
--- PASS: TestPurge (15.81s)
=== RUN   TestRmdirsNoLeaveRoot
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:47:58 DEBUG : A1/B1/C1/one: md5 = 2318017ec4d2e5d6174a585260fafb51 OK
2026/11/05 04:47:58 INFO  : A2: Making directory
2026/11/05 04:47:59 INFO  : A1/B2: Making directory
2026/11/05 04:48:00 INFO  : A1/B2/C2: Making directory
2026/11/05 04:48:01 INFO  : A1/B1/C3: Making directory
2026/11/05 04:48:01 INFO  : A3: Making directory
2026/11/05 04:48:02 INFO  : A3/B3: Making directory
2026/11/05 04:48:03 INFO  : A3/B3/C4: Making directory
2026/11/05 04:48:05 DEBUG : A1/two: md5 = 9746a5b0dc6b0b7e7bc079f6e7c4fa73 OK
2026/11/05 04:48:06 DEBUG : removing 1 level 3 directories
2026/11/05 04:48:06 INFO  : A3/B3/C4: Removing directory
2026/11/05 04:48:09 DEBUG : removing 2 level 3 directories
2026/11/05 04:48:09 INFO  : A1/B2/C2: Removing directory
2026/11/05 04:48:09 INFO  : A1/B1/C3: Removing directory
2026/11/05 04:48:10 DEBUG : removing 2 level 2 directories
2026/11/05 04:48:10 INFO  : A3/B3: Removing directory
2026/11/05 04:48:10 INFO  : A1/B2: Removing directory
2026/11/05 04:48:10 DEBUG : removing 2 level 1 directories
2026/11/05 04:48:10 INFO  : A3: Removing directory
2026/11/05 04:48:10 INFO  : A2: Removing directory
2026/11/05 04:48:14 DEBUG : removing 1 level 3 directories
2026/11/05 04:48:14 INFO  : A1/B1/C1: Removing directory
2026/11/05 04:48:15 DEBUG : removing 1 level 2 directories
2026/11/05 04:48:15 INFO  : A1/B1: Removing directory
2026/11/05 04:48:16 DEBUG : removing 1 level 1 directories
2026/11/05 04:48:16 INFO  : A1: Removing directory
2026/11/05 04:48:17 DEBUG : removing 1 level 0 directories
2026/11/05 04:48:17 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Removing directory
--- PASS: TestRmdirsNoLeaveRoot (23.25s)
=== RUN   TestRmdirsLeaveRoot
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:48:19 INFO  : A1: Making directory
2026/11/05 04:48:19 INFO  : A1/B1: Making directory
2026/11/05 04:48:20 INFO  : A1/B1/C1: Making directory
2026/11/05 04:48:23 DEBUG : removing 1 level 3 directories
2026/11/05 04:48:23 INFO  : A1/B1/C1: Removing directory
2026/11/05 04:48:23 DEBUG : removing 1 level 2 directories
2026/11/05 04:48:23 INFO  : A1/B1: Removing directory
--- PASS: TestRmdirsLeaveRoot (7.83s)
=== RUN   TestRmdirsWithFilter
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:48:26 INFO  : A1: Making directory
2026/11/05 04:48:27 INFO  : A1/B1: Making directory
2026/11/05 04:48:27 INFO  : A1/B1/C1: Making directory
2026/11/05 04:48:30 DEBUG : removing 1 level 3 directories
2026/11/05 04:48:30 INFO  : A1/B1/C1: Removing directory
2026/11/05 04:48:31 DEBUG : removing 1 level 2 directories
2026/11/05 04:48:31 INFO  : A1/B1: Removing directory
--- PASS: TestRmdirsWithFilter (7.43s)
=== RUN   TestCopyURL
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:48:35 DEBUG : file1: md5 = e08e4ad8740f4545e4be0a7025dcd839 OK
2026/11/05 04:48:35 DEBUG : file1: size = 14 OK
2026/11/05 04:48:35 DEBUG : filename.txt: File name found in url
2026/11/05 04:48:37 DEBUG : filename.txt: md5 = 1839ba6d8559cf338d32148efaec5d44 OK
2026/11/05 04:48:37 DEBUG : filename.txt: size = 14 OK
2026/11/05 04:48:37 DEBUG : headerfilename.txt: filename found in Content-Disposition header.
2026/11/05 04:48:38 DEBUG : headerfilename.txt: md5 = 952c3e5ffedf855b1cf70972b9fcd8ee OK
2026/11/05 04:48:38 DEBUG : headerfilename.txt: size = 14 OK
2026/11/05 04:48:40 DEBUG : file2: md5 = 780ce1d55e15a908dc5bb012416ba0fc OK
2026/11/05 04:48:40 DEBUG : file2: size = 14 OK
--- PASS: TestCopyURL (8.84s)
=== RUN   TestCopyURLDownloadHeaders
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:48:44 DEBUG : file1: md5 = 133d8ade59ef333d8d1adc7996e76051 OK
2026/11/05 04:48:44 DEBUG : file1: size = 14 OK
--- PASS: TestCopyURLDownloadHeaders (2.32s)
=== RUN   TestCopyURLToWriter
--- PASS: TestCopyURLToWriter (0.00s)
=== RUN   TestMoveFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:48:45 DEBUG : file1: Need to transfer - File not found at Destination
2026/11/05 04:48:47 DEBUG : sub/file2: md5 = e2253ab1ff3a862d416fe30cbb56ade0 OK
2026/11/05 04:48:47 DEBUG : sub/file2: size = 14 OK
2026/11/05 04:48:47 INFO  : file1: Copied (new) to: sub/file2
2026/11/05 04:48:47 INFO  : file1: Deleted
2026/11/05 04:48:48 DEBUG : sub/file2: size = 14 OK
2026/11/05 04:48:48 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/05 04:48:48 DEBUG : file1: Unchanged skipping
2026/11/05 04:48:48 INFO  : file1: Deleted
2026/11/05 04:48:48 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': don't need to copy/move sub/file2, it is already at target location
--- PASS: TestMoveFile (5.91s)
=== RUN   TestMoveFileWithIgnoreExisting
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:48:51 DEBUG : file1: Need to transfer - File not found at Destination
2026/11/05 04:48:52 DEBUG : file1: md5 = 5fd652723c974678b067a72a3f945fab OK
2026/11/05 04:48:52 DEBUG : file1: size = 14 OK
2026/11/05 04:48:52 INFO  : file1: Copied (new)
2026/11/05 04:48:52 INFO  : file1: Deleted
2026/11/05 04:48:52 DEBUG : file1: Destination exists, skipping
2026/11/05 04:48:52 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set
--- PASS: TestMoveFileWithIgnoreExisting (3.14s)
=== RUN   TestMoveFileImmutable
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:48:55 DEBUG : existing: md5 = 27d654d785345b157a9d4425398da2b0 OK
2026/11/05 04:48:55 DEBUG : existing: size = 8 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:48:55 DEBUG : existing: size = 6 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi')
2026/11/05 04:48:55 DEBUG : existing: Sizes differ
2026/11/05 04:48:55 ERROR : existing: Source and destination exist but do not match: immutable file modified
--- PASS: TestMoveFileImmutable (2.97s)
=== RUN   TestCaseInsensitiveMoveFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
--- PASS: TestCaseInsensitiveMoveFile (0.47s)
=== RUN   TestMoveOntoItself
=== RUN   TestMoveOntoItself/viaSubdir=false,disableMove=false
2026/11/05 04:48:57 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-muboxad4giwi"
2026/11/05 04:48:57 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:48:57 DEBUG : Creating backend with remote "TestDrive:crypt/8sp8ubjacgd8qi8g5vh2pspqvddspmajj9kd45qmosc11t5cut9g"
2026/11/05 04:48:58 DEBUG : Creating backend with remote "/tmp/rclone3519482703"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-muboxad4giwi'", Local "Local file system at /tmp/rclone3519482703", Modify Window "1ms"
2026/11/05 04:49:01 DEBUG : sub/file1: md5 = f6ead140682222c956c602d20404d1d5 OK
2026/11/05 04:49:02 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-muboxad4giwi': Purge remote
=== RUN   TestMoveOntoItself/viaSubdir=false,disableMove=true
2026/11/05 04:49:02 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-nusefuh1siwu"
2026/11/05 04:49:02 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:49:02 DEBUG : Creating backend with remote "TestDrive:crypt/fh9njrssqqbtd2q9ieaglmdbup341ejemugnsgu9ckvdiuufs8lg"
2026/11/05 04:49:03 DEBUG : Creating backend with remote "/tmp/rclone1636251012"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-nusefuh1siwu'", Local "Local file system at /tmp/rclone1636251012", Modify Window "1ms"
2026/11/05 04:49:06 DEBUG : sub/file1: md5 = 8fb0a13c8d0c531787a8717aae676058 OK
2026/11/05 04:49:06 DEBUG : Reset feature "Move"
2026/11/05 04:49:07 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-nusefuh1siwu': Purge remote
=== RUN   TestMoveOntoItself/viaSubdir=true,disableMove=false
2026/11/05 04:49:07 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-yemijes0gasi"
2026/11/05 04:49:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:49:07 DEBUG : Creating backend with remote "TestDrive:crypt/cjhhjmfhadpcd3akp7irlgfsq8jsdhnnofsvngdmuh8rjthmn4bg"
2026/11/05 04:49:08 DEBUG : Creating backend with remote "/tmp/rclone2885917861"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-yemijes0gasi'", Local "Local file system at /tmp/rclone2885917861", Modify Window "1ms"
2026/11/05 04:49:11 DEBUG : sub/file1: md5 = 819d03191cc1b3550832132503f20038 OK
2026/11/05 04:49:11 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-yemijes0gasi/sub"
2026/11/05 04:49:11 DEBUG : Creating backend with remote "TestDrive:crypt/cjhhjmfhadpcd3akp7irlgfsq8jsdhnnofsvngdmuh8rjthmn4bg/150fuo3cn4j1uenq6r4g4qk6t4"
2026/11/05 04:49:12 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-yemijes0gasi': Purge remote
=== RUN   TestMoveOntoItself/viaSubdir=true,disableMove=true
2026/11/05 04:49:13 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-rinedid7vumu"
2026/11/05 04:49:13 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:49:13 DEBUG : Creating backend with remote "TestDrive:crypt/5sd0957k1hmal82bd9a9mnp1j18a556rv2431ck4aqgpk0ovevo0"
2026/11/05 04:49:14 DEBUG : Creating backend with remote "/tmp/rclone3336186601"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-rinedid7vumu'", Local "Local file system at /tmp/rclone3336186601", Modify Window "1ms"
2026/11/05 04:49:17 DEBUG : sub/file1: md5 = 0aabdf5e3bc295467d553e695115ba13 OK
2026/11/05 04:49:17 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-rinedid7vumu/sub"
2026/11/05 04:49:17 DEBUG : Creating backend with remote "TestDrive:crypt/5sd0957k1hmal82bd9a9mnp1j18a556rv2431ck4aqgpk0ovevo0/150fuo3cn4j1uenq6r4g4qk6t4"
2026/11/05 04:49:18 DEBUG : Reset feature "Move"
2026/11/05 04:49:18 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-rinedid7vumu': Purge remote
--- PASS: TestMoveOntoItself (21.93s)
    --- PASS: TestMoveOntoItself/viaSubdir=false,disableMove=false (5.00s)
    --- PASS: TestMoveOntoItself/viaSubdir=false,disableMove=true (4.99s)
    --- PASS: TestMoveOntoItself/viaSubdir=true,disableMove=false (6.00s)
    --- PASS: TestMoveOntoItself/viaSubdir=true,disableMove=true (5.93s)
=== RUN   TestMoveUnicodeEquivalentWithoutServerSideMove
2026/11/05 04:49:19 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-disuwuv7bigi"
2026/11/05 04:49:19 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:49:19 DEBUG : Creating backend with remote "TestDrive:crypt/otmpofqm4sh9npsmbdqm3ep3gtep1amfg488uejla4ngjter3fbg"
2026/11/05 04:49:20 DEBUG : Creating backend with remote "/tmp/rclone823784878"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-disuwuv7bigi'", Local "Local file system at /tmp/rclone823784878", Modify Window "1ms"
2026/11/05 04:49:20 DEBUG : Reset feature "Move"
2026/11/05 04:49:23 DEBUG : sub/équivalent.txt: md5 = 80d12cb22a49aab1c9a72316c8690859 OK
2026/11/05 04:49:23 DEBUG : sub/équivalent.txt: moving to sub/équivalent.txt-rclone-move-tizeduk0
2026/11/05 04:49:24 DEBUG : sub/équivalent.txt-rclone-move-tizeduk0: size = 14 OK
2026/11/05 04:49:24 INFO  : sub/équivalent.txt: Copied (server-side copy) to: sub/équivalent.txt-rclone-move-tizeduk0
2026/11/05 04:49:25 INFO  : sub/équivalent.txt: Deleted
2026/11/05 04:49:25 DEBUG : sub/équivalent.txt: moving to sub/équivalent.txt
2026/11/05 04:49:26 DEBUG : sub/équivalent.txt: size = 14 OK
2026/11/05 04:49:26 INFO  : sub/équivalent.txt-rclone-move-tizeduk0: Copied (server-side copy) to: sub/équivalent.txt
2026/11/05 04:49:26 INFO  : sub/équivalent.txt-rclone-move-tizeduk0: Deleted
2026/11/05 04:49:27 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-disuwuv7bigi': Purge remote
--- PASS: TestMoveUnicodeEquivalentWithoutServerSideMove (8.48s)
=== RUN   TestCaseInsensitiveMoveWithoutServerSideMove
2026/11/05 04:49:27 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pamuvar7zuwi"
2026/11/05 04:49:27 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/05 04:49:27 DEBUG : Creating backend with remote "TestDrive:crypt/jt3jnge57u1bh7iqdc9888up88911uksubartl27sdf11u8upmsg"
2026/11/05 04:49:28 DEBUG : Creating backend with remote "/tmp/rclone1749943348"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pamuvar7zuwi'", Local "Local file system at /tmp/rclone1749943348", Modify Window "1ms"
    operations_test.go:1198: remote is case sensitive
2026/11/05 04:49:28 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pamuvar7zuwi': Purge remote
2026/11/05 04:49:29 NOTICE: purge failed: directory not found
--- SKIP: TestCaseInsensitiveMoveWithoutServerSideMove (1.16s)
=== RUN   TestCaseInsensitiveMoveFileDryRun
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
--- PASS: TestCaseInsensitiveMoveFileDryRun (0.44s)
=== RUN   TestMoveFileBackupDir
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:49:31 DEBUG : dst/file1: md5 = 9aa1c141d15eafa8321db677f2e1f26c OK
2026/11/05 04:49:32 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-metujur0duyi/backup"
2026/11/05 04:49:32 DEBUG : Creating backend with remote "TestDrive:crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0/1nrff024r7pq65ecp72fc28jb0"
2026/11/05 04:49:33 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone4040252718)
2026/11/05 04:49:33 DEBUG : dst/file1: size = 18 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi')
2026/11/05 04:49:33 DEBUG : dst/file1: Sizes differ
2026/11/05 04:49:36 INFO  : dst/file1: Moved (server-side)
2026/11/05 04:49:37 DEBUG : dst/file1: md5 = 08cacdfc0cac8dca1e92ae836c91460f OK
2026/11/05 04:49:37 DEBUG : dst/file1: size = 14 OK
2026/11/05 04:49:37 INFO  : dst/file1: Copied (new)
2026/11/05 04:49:37 INFO  : dst/file1: Deleted
--- PASS: TestMoveFileBackupDir (12.66s)
=== 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:49:44 DEBUG : A/file0: md5 = 88d808da8ed78babaee76e2096fff060 OK
2026/11/05 04:49:45 DEBUG : A/file1: md5 = 9c8966b88228bd3cbc1acd7dd0b2230e OK
2026/11/05 04:49:47 DEBUG : A/file2: md5 = b01a33c90c27e1710ad31027630e491d OK
2026/11/05 04:49:48 DEBUG : A/file3: md5 = eb1263a17fef1931edb162391e7de855 OK
2026/11/05 04:49:50 DEBUG : A/file4: md5 = 3ddb469b3e8302d42e069ea40dda0520 OK
2026/11/05 04:49:51 DEBUG : A/file5: md5 = 0fb89d8a71f7e91d140045567b5632f8 OK
2026/11/05 04:49:53 DEBUG : A/file6: md5 = 910157002a32b82afa440f9a63509531 OK
2026/11/05 04:49:54 DEBUG : A/file7: md5 = 712022732797f2e064935e47accd51cf OK
2026/11/05 04:49:55 DEBUG : A/file8: md5 = 63bb2e2885275a72850ef62f24343c77 OK
2026/11/05 04:49:57 DEBUG : A/file9: md5 = f191d25574547c9d881826cf61735e61 OK
2026/11/05 04:49:58 DEBUG : A/file10: md5 = 3beea44e2db668decf0286b94468ed55 OK
2026/11/05 04:50:00 DEBUG : A/file11: md5 = b9ccadca16912c760d8376dd1f529827 OK
2026/11/05 04:50:01 DEBUG : A/file12: md5 = f6c7ede631321ab1b4a5adbe41af7bc3 OK
2026/11/05 04:50:03 DEBUG : A/file13: md5 = eebd57c14faaa53e3ac2a8d97302cfb5 OK
2026/11/05 04:50:04 DEBUG : A/file14: md5 = c1835cfc521d9c5115a08a4abbc34c53 OK
2026/11/05 04:50:06 DEBUG : A/file15: md5 = 7a85f67812fa8f3d1ebd97bb34062caf OK
2026/11/05 04:50:07 DEBUG : A/file16: md5 = 046dcf8c37b3344159d961fbfba2ccb6 OK
2026/11/05 04:50:08 DEBUG : A/file17: md5 = 20ece1181eab12c0b9f0307ac544aec5 OK
2026/11/05 04:50:10 DEBUG : A/file18: md5 = 95a283552cfd3f305304acbea63d8436 OK
2026/11/05 04:50:11 DEBUG : A/file19: md5 = bad013ac224beabf74b011e9258c442b OK
    operations_test.go:1563: Skipping test on non local remote
--- SKIP: TestDirMoveMoveError (39.78s)
=== RUN   TestDirMoveContext
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:50:23 DEBUG : A/one: md5 = ecc3ef227a319f1dea5e1d7585b3d955 OK
2026/11/05 04:50:25 DEBUG : A/two: md5 = 8f177fd568fec188e1d3149cfe0e495b OK
    operations_test.go:1563: Skipping test on non local remote
--- SKIP: TestDirMoveContext (5.65s)
=== RUN   TestDirMove
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:50:29 DEBUG : A1/one: md5 = ed44e42311e45460c15354a24a9b5f11 OK
2026/11/05 04:50:31 DEBUG : A1/two: md5 = cd7c4357d8f210424ffab1ffe971eddf OK
2026/11/05 04:50:33 DEBUG : A1/B1/three: md5 = 242f41110ad171a7f31bc22001e4ec44 OK
2026/11/05 04:50:35 DEBUG : A1/B1/C1/four: md5 = ba13c9514e4f74d53b6ecb787dd247b1 OK
2026/11/05 04:50:37 DEBUG : A1/B1/C2/five: md5 = 195d84e53c7ed954288cf82b9fd280ac OK
2026/11/05 04:50:37 INFO  : A1/B2: Making directory
2026/11/05 04:50:38 INFO  : A1/B1/C3: Making directory
2026/11/05 04:50:47 INFO  : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five
2026/11/05 04:50:47 INFO  : A2/one: Moved (server-side) to: A3/one
2026/11/05 04:50:47 INFO  : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four
2026/11/05 04:50:47 INFO  : A2/B1/three: Moved (server-side) to: A3/B1/three
2026/11/05 04:50:47 INFO  : A2/two: Moved (server-side) to: A3/two
2026/11/05 04:50:53 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2026/11/05 04:50:58 INFO  : A3/one: Moved (server-side) to: A4/one
2026/11/05 04:50:58 INFO  : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five
2026/11/05 04:50:58 INFO  : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four
2026/11/05 04:50:59 INFO  : A3/two: Moved (server-side) to: A4/two
2026/11/05 04:50:59 INFO  : A3/B1/three: Moved (server-side) to: A4/B1/three
--- PASS: TestDirMove (43.88s)
=== RUN   TestGetFsInfo
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:11 DEBUG : Config file has changed externally - reloading
--- PASS: TestGetFsInfo (0.48s)
=== RUN   TestRcat
=== RUN   TestRcat/withChecksum=false,ignoreChecksum=false
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:12 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': File to upload is small (34 bytes), uploading instead of streaming
2026/11/05 04:51:13 DEBUG : no_checksum_small_file_from_pipe: md5 = feee6022ae41ac99afed3195b73011ed OK
2026/11/05 04:51:13 DEBUG : no_checksum_small_file_from_pipe: size = 34 OK
2026/11/05 04:51:13 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only
2026/11/05 04:51:13 DEBUG : no_checksum_small_file_from_pipe: Size of src and dst objects identical
2026/11/05 04:51:14 DEBUG : qc9k4uauqa9ls6a2r6lo8jf4b1m7r0510pkurois1cc70egbs4h0: Sending chunk 0 length 102465
2026/11/05 04:51:15 DEBUG : no_checksum_big_file_from_pipe: md5 = 0f8be143d55f4fabb21a10485889823a OK
2026/11/05 04:51:15 DEBUG : no_checksum_big_file_from_pipe: size = 102401 OK
2026/11/05 04:51:15 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:16 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': File to upload is small (34 bytes), uploading instead of streaming
2026/11/05 04:51:18 DEBUG : with_checksum_small_file_from_pipe: md5 = 4cfeac4985642af219fdac46f171ba5f OK
2026/11/05 04:51:18 DEBUG : with_checksum_small_file_from_pipe: size = 34 OK
2026/11/05 04:51:18 DEBUG : with_checksum_small_file_from_pipe: Size of src and dst objects identical
2026/11/05 04:51:19 DEBUG : e74jo8a7lr1aimg2u78fct67gnuetc1qujiofaci0c8fnq7rjt1d4i296pcklqhgdihs03etvgdi4: Sending chunk 0 length 102465
2026/11/05 04:51:20 DEBUG : with_checksum_big_file_from_pipe: md5 = ad5560c950a7454f0dc14c27ba57f552 OK
2026/11/05 04:51:20 DEBUG : with_checksum_big_file_from_pipe: size = 102401 OK
2026/11/05 04:51:20 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:22 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': File to upload is small (34 bytes), uploading instead of streaming
2026/11/05 04:51:23 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK
2026/11/05 04:51:23 DEBUG : ignore_checksum_small_file_from_pipe: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/05 04:51:24 DEBUG : 1963rn6olajfbjn4nbqi9nacu7bk879vpf0d2bg8r0ndcqqsfntob0urt056p0qujf574rqnb5f62: Sending chunk 0 length 102465
2026/11/05 04:51:25 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK
2026/11/05 04:51:25 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-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:27 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': File to upload is small (34 bytes), uploading instead of streaming
2026/11/05 04:51:28 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK
2026/11/05 04:51:28 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical
2026/11/05 04:51:29 DEBUG : 1963rn6olajfbjn4nbqi9nacu7bk879vpf0d2bg8r0ndcqqsfntob0urt056p0qujf574rqnb5f62: Sending chunk 0 length 102465
2026/11/05 04:51:30 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK
2026/11/05 04:51:30 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical
--- PASS: TestRcat (20.21s)
    --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (4.83s)
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (5.33s)
    --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (5.25s)
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (4.79s)
=== RUN   TestRcatMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
=== RUN   TestRcatMetadata/Normal
2026/11/05 04:51:32 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': File to upload is small (48 bytes), uploading instead of streaming
2026/11/05 04:51:33 DEBUG : rcat_metadata: md5 = b31447f65f8f6c161b9af41b3d913c64 OK
2026/11/05 04:51:33 DEBUG : rcat_metadata: size = 48 OK
2026/11/05 04:51:33 DEBUG : rcat_metadata: Size of src and dst objects identical
=== RUN   TestRcatMetadata/ViaDisk
2026/11/05 04:51:35 DEBUG : rijssoobhbn85c5p1imhg55m6frank1nlplla6hkdjlqmqb2471g: Sending chunk 0 length 111
2026/11/05 04:51:36 DEBUG : rcat_metadata_uploadcutoff0: md5 = 0bbf2241f3ac4154d46e6a46ff48c4ed OK
2026/11/05 04:51:36 DEBUG : rcat_metadata_uploadcutoff0: size = 63 OK
2026/11/05 04:51:36 DEBUG : rcat_metadata_uploadcutoff0: Size of src and dst objects identical
--- PASS: TestRcatMetadata (5.68s)
    --- PASS: TestRcatMetadata/Normal (2.52s)
    --- PASS: TestRcatMetadata/ViaDisk (2.70s)
=== RUN   TestRcatSize
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:39 DEBUG : potato1: md5 = b535c6e46914fda73485ae7b1b5644d6 OK
2026/11/05 04:51:39 DEBUG : potato1: size = 60 OK
2026/11/05 04:51:39 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': File to upload is small (60 bytes), uploading instead of streaming
2026/11/05 04:51:40 DEBUG : potato2: md5 = 905026cfef64e83160bb886a49e1bea0 OK
2026/11/05 04:51:40 DEBUG : potato2: size = 60 OK
2026/11/05 04:51:40 DEBUG : potato2: Size of src and dst objects identical
--- PASS: TestRcatSize (4.54s)
=== RUN   TestRcatSizeShortEOF
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:43 DEBUG : potato1: md5 = cb723c6043d5a2ec04f458cf443806e4 OK
2026/11/05 04:51:43 DEBUG : potato1: size = 120 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi')
2026/11/05 04:51:43 DEBUG : potato1: size = 60 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi')
2026/11/05 04:51:43 ERROR : potato1: corrupted on transfer: sizes differ src 120 vs dst(Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi') 60
2026/11/05 04:51:43 INFO  : potato1: Removing failed copy
--- PASS: TestRcatSizeShortEOF (2.30s)
=== RUN   TestRcatSizeMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:46 DEBUG : potato1: md5 = 5354ddb468a2589287519bc1542a3064 OK
2026/11/05 04:51:46 DEBUG : potato1: size = 60 OK
2026/11/05 04:51:46 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': File to upload is small (60 bytes), uploading instead of streaming
2026/11/05 04:51:47 DEBUG : potato2: md5 = 0cd2e5242217cf6b95f5c26314afa609 OK
2026/11/05 04:51:47 DEBUG : potato2: size = 60 OK
2026/11/05 04:51:47 DEBUG : potato2: Size of src and dst objects identical
--- PASS: TestRcatSizeMetadata (5.30s)
=== RUN   TestRcatSizeUploadHeaders
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:51 DEBUG : potato1: md5 = 894bfa396228d7d182d485ec7d1b84c5 OK
2026/11/05 04:51:51 DEBUG : potato1: size = 60 OK
--- PASS: TestRcatSizeUploadHeaders (2.46s)
=== RUN   TestRcatSizeChecksum
=== RUN   TestRcatSizeChecksum/Corrupted
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
    operations_test.go:2048: Skipping as destination doesn't support hashes
=== RUN   TestRcatSizeChecksum/SizeDiffers
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:54 DEBUG : potato4: md5 = 0bbbd65787dbb5f8e23066884f589dac OK
2026/11/05 04:51:54 DEBUG : potato4: size = 60 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi')
2026/11/05 04:51:54 DEBUG : potato4: size = 59 (Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi')
2026/11/05 04:51:54 ERROR : potato4: corrupted on transfer: sizes differ src 60 vs dst(Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi') 59
2026/11/05 04:51:54 INFO  : potato4: Removing failed copy
=== RUN   TestRcatSizeChecksum/IgnoreChecksum
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:56 DEBUG : potato2: size = 60 OK
=== RUN   TestRcatSizeChecksum/NoHashes
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:51:58 DEBUG : potato3: md5 = d6d514669eba4d9ca07aee58e1cf241a OK
2026/11/05 04:51:58 DEBUG : potato3: size = 60 OK
--- PASS: TestRcatSizeChecksum (7.40s)
    --- SKIP: TestRcatSizeChecksum/Corrupted (0.42s)
    --- PASS: TestRcatSizeChecksum/SizeDiffers (2.44s)
    --- PASS: TestRcatSizeChecksum/IgnoreChecksum (2.30s)
    --- PASS: TestRcatSizeChecksum/NoHashes (2.24s)
=== RUN   TestTouchDir
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:52:01 DEBUG : potato2: md5 = e8fe22973d7b92ea6893b90bb4a2bc74 OK
2026/11/05 04:52:02 DEBUG : empty space: md5 = 5a75516cf0e6e18d43a1fb792adb6322 OK
2026/11/05 04:52:04 DEBUG : sub dir/potato3: md5 = a6783aee583d7a8ac527925f7d8070c0 OK
2026/11/05 04:52:05 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Touching "sub dir/potato3"
2026/11/05 04:52:05 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Touching "empty space"
2026/11/05 04:52:05 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Touching "potato2"
--- PASS: TestTouchDir (9.85s)
=== RUN   TestMkdirMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:52:09 DEBUG : dir with metadata: Making directory with metadata
2026/11/05 04:52:10 INFO  : dir with metadata: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
--- PASS: TestMkdirMetadata (2.70s)
=== RUN   TestMkdirModTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:52:12 DEBUG : directory with modtime: Making directory with metadata
2026/11/05 04:52:14 INFO  : directory with modtime: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/11/05 04:52:14 NOTICE: dry run directory with modtime: Skipped make directory as --dry-run is set
--- PASS: TestMkdirModTime (3.39s)
=== RUN   TestCopyDirMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:52:15 DEBUG : dir with metadata to be copied: Making directory with metadata
2026/11/05 04:52:15 INFO  : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/11/05 04:52:15 DEBUG : Google drive root 'crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0': Skipping btime metadata as can't update it on an existing file: 2026-11-05T04:52:15.774376752Z
2026/11/05 04:52:16 INFO  : non existent directory: Updated directory metadata
2026/11/05 04:52:18 DEBUG : Google drive root 'crypt/89sp6grchbnf0fh8fl7lb29c4u5si2g9v92lbc5lccdqrrma17q0': Skipping btime metadata as can't update it on an existing file: 2026-11-05T04:52:15.774376752Z
2026/11/05 04:52:18 INFO  : existing directory: Updated directory metadata
--- PASS: TestCopyDirMetadata (4.65s)
=== RUN   TestSetDirModTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:52:20 DEBUG : set modtime on non existent directory: Skipping set directory modification time as --no-update-dir-modtime is set
2026/11/05 04:52:21 INFO  : set modtime on existing directory: Set directory modification time (using SetModTime)
2026/11/05 04:52:22 INFO  : set modtime on existing directory: Set directory modification time (using DirSetModTime)
--- PASS: TestSetDirModTime (3.76s)
=== RUN   TestDirsEqual
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:52:24 DEBUG : dir with metadata to be copied: Making directory with metadata
2026/11/05 04:52:24 INFO  : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/11/05 04:52:24 DEBUG : dst: Making directory with metadata
2026/11/05 04:52:24 INFO  : dst: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/11/05 04:52:24 DEBUG : dst: Directory modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/05 04:52:25 INFO  : dst: Set directory modification time (using SetModTime)
2026/11/05 04:52:25 INFO  : dst: Set directory modification time (using SetModTime)
2026/11/05 04:52:25 DEBUG : dst: Directory modification time the same (differ by 1ns, within tolerance 1ms)
2026/11/05 04:52:26 INFO  : dst: Set directory modification time (using SetModTime)
2026/11/05 04:52:26 DEBUG : dst: Destination directory is newer than source, skipping
--- PASS: TestDirsEqual (3.52s)
=== RUN   TestRemoveExisting
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi'", Local "Local file system at /tmp/rclone4040252718", Modify Window "1ms"
2026/11/05 04:52:29 DEBUG : sub dir/test remove existing: md5 = da6e5a9d746decb25562aba3a962c6ea OK
2026/11/05 04:52:31 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: md5 = 67dbd6a07780cb1ddc8a8077d4ee1d22 OK
2026/11/05 04:52:33 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.loporuc2" before starting
2026/11/05 04:52:34 DEBUG : sub dir/test remove existing.loporuc2: TEST: removing renamed existing file after operation
2026/11/05 04:52:35 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.nenelaf9" before starting
2026/11/05 04:52:36 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.nenelaf9: TEST: renaming existing back after failed operation
2026/11/05 04:52:37 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.qetirop9" before starting
2026/11/05 04:52:38 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.qetirop9: TEST: removing renamed existing file after operation
--- PASS: TestRemoveExisting (13.28s)
=== RUN   TestRcatInputFailurePreservesDestination
2026/11/05 04:52:40 DEBUG : Creating backend with remote "/tmp/TestRcatInputFailurePreservesDestination291293978/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/11/05 04:52:40 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-metujur0duyi': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptDrive: -verbose" - Finished OK in 21m29.456431886s (try 1/5)