"./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptDrive: -verbose -fast-list" - Starting (try 1/5)
2026/11/11 03:26:28 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka"
2026/11/11 03:26:28 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:26:28 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0"
2026/11/11 03:26:29 DEBUG : Creating backend with remote "/tmp/rclone875949583"
=== 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
    multithread_test.go:120: multithread writing not supported
--- SKIP: TestMultithreadCopy (0.21s)
=== RUN   TestMultithreadCopyAbort
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
    multithread_test.go:120: multithread writing not supported
--- SKIP: TestMultithreadCopyAbort (0.24s)
=== RUN   TestMultithreadCopyWriterAtErrors
=== RUN   TestMultithreadCopyWriterAtErrors/open/fatal=false
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
=== RUN   TestMultithreadCopyWriterAtErrors/open/fatal=true
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
=== RUN   TestMultithreadCopyWriterAtErrors/write/fatal=false
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/11/11 03:26:30 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 1
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 2
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 0
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/11/11 03:26:30 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/11 03:26:30 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/11/11 03:26:30 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 1
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 2/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 2
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 3/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 0
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 1/4 failed: multi-thread copy: failed to write chunk: disk full
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/11/11 03:26:30 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/11 03:26:30 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/11/11 03:26:30 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 1
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 0
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 2
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 3
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/11/11 03:26:30 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/11 03:26:30 DEBUG : file.txt: multi-thread copy: disabling buffering because destination uses OpenWriterAt
2026/11/11 03:26:30 DEBUG : file.txt: Starting multi-thread copy with 4 chunks of size 4 with 2 parallel streams
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 1
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 2/4 (4-8) size 4 finished
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 2
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 3/4 (8-12) size 4 finished
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 3
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 4/4 (12-16) size 4 finished
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 starting
2026/11/11 03:26:30 DEBUG : file.txt: writing chunk 0
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: chunk 1/4 (0-4) size 4 finished
2026/11/11 03:26:30 DEBUG : file.txt: multi-thread copy: cancelling transfer on exit
2026/11/11 03:26:30 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/11 03:26:30 DEBUG : a: size = 0 OK
2026/11/11 03:26:30 DEBUG : a: size = 1 (memory)
2026/11/11 03:26:30 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/11 03:26:30 DEBUG : potato: Seek from 10 to 0
=== RUN   TestReOpen/Normal/ErrorAtStart
=== RUN   TestReOpen/Normal/WithErrors
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/Normal/TooManyErrors
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/Normal/ReadAt
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/Normal/Seek
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Seek from 5 to 2
=== RUN   TestReOpen/Normal/AccountRead
=== RUN   TestReOpen/Normal/AccountReadDelay
2026/11/11 03:26:30 DEBUG : potato: Seek from 10 to 0
2026/11/11 03:26:30 DEBUG : potato: Seek from 10 to 0
2026/11/11 03:26:30 DEBUG : potato: Seek from 10 to 0
=== RUN   TestReOpen/Normal/AccountReadError
=== RUN   TestReOpen/WithRangeOption
=== RUN   TestReOpen/WithRangeOption/Basics
2026/11/11 03:26:30 DEBUG : potato: Seek from 7 to 0
=== RUN   TestReOpen/WithRangeOption/ErrorAtStart
=== RUN   TestReOpen/WithRangeOption/WithErrors
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/WithRangeOption/TooManyErrors
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/WithRangeOption/ReadAt
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/WithRangeOption/Seek
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Seek from 5 to 2
2026/11/11 03:26:30 DEBUG : potato: Seek from 7 to 4
=== RUN   TestReOpen/WithRangeOption/AccountRead
=== RUN   TestReOpen/WithRangeOption/AccountReadDelay
2026/11/11 03:26:30 DEBUG : potato: Seek from 7 to 0
2026/11/11 03:26:30 DEBUG : potato: Seek from 7 to 0
2026/11/11 03:26:30 DEBUG : potato: Seek from 7 to 0
=== RUN   TestReOpen/WithRangeOption/AccountReadError
=== RUN   TestReOpen/WithSeekOption
=== RUN   TestReOpen/WithSeekOption/Basics
2026/11/11 03:26:30 DEBUG : potato: Seek from 8 to 0
=== RUN   TestReOpen/WithSeekOption/ErrorAtStart
=== RUN   TestReOpen/WithSeekOption/WithErrors
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/WithSeekOption/TooManyErrors
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/WithSeekOption/ReadAt
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/WithSeekOption/Seek
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Seek from 5 to 2
2026/11/11 03:26:30 DEBUG : potato: Seek from 7 to 5
=== RUN   TestReOpen/WithSeekOption/AccountRead
=== RUN   TestReOpen/WithSeekOption/AccountReadDelay
2026/11/11 03:26:30 DEBUG : potato: Seek from 8 to 0
2026/11/11 03:26:30 DEBUG : potato: Seek from 8 to 0
2026/11/11 03:26:30 DEBUG : potato: Seek from 8 to 0
=== RUN   TestReOpen/WithSeekOption/AccountReadError
=== RUN   TestReOpen/UnknownSize
=== RUN   TestReOpen/UnknownSize/Basics
2026/11/11 03:26:30 DEBUG : potato: Seek from 9 to 0
=== RUN   TestReOpen/UnknownSize/ErrorAtStart
=== RUN   TestReOpen/UnknownSize/WithErrors
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error
=== RUN   TestReOpen/UnknownSize/TooManyErrors
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error
2026/11/11 03:26:30 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries
=== RUN   TestReOpen/UnknownSize/ReadAt
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Seek from 5 to 1
=== RUN   TestReOpen/UnknownSize/Seek
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error
2026/11/11 03:26:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error
2026/11/11 03:26:30 DEBUG : potato: Seek from 5 to 2
2026/11/11 03:26:30 DEBUG : potato: Seek from 7 to 6
=== RUN   TestReOpen/UnknownSize/AccountRead
=== RUN   TestReOpen/UnknownSize/AccountReadDelay
2026/11/11 03:26:30 DEBUG : potato: Seek from 9 to 0
2026/11/11 03:26:30 DEBUG : potato: Seek from 9 to 0
2026/11/11 03:26:30 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:26:32 DEBUG : rutabaga: md5 = 3300adb5076952184d590f7f0e41e4b7 OK
=== RUN   TestCheck/1
=== RUN   TestCheck/2
2026/11/11 03:26:34 DEBUG : empty space: md5 = a58bc1c2537993f3abad8c9d6cb64a5d OK
=== RUN   TestCheck/3
2026/11/11 03:26:36 DEBUG : potato2: md5 = 5646062bda9dbe598f1f86d4fae41002 OK
=== RUN   TestCheck/4
=== RUN   TestCheck/5
2026/11/11 03:26:38 DEBUG : remotepotato: md5 = 843a20de6d1221a83629fe53058a74f6 OK
=== RUN   TestCheck/6
=== RUN   TestCheck/7
--- PASS: TestCheck (11.72s)
    --- PASS: TestCheck/1 (0.34s)
    --- PASS: TestCheck/2 (0.22s)
    --- PASS: TestCheck/3 (0.26s)
    --- PASS: TestCheck/4 (0.26s)
    --- PASS: TestCheck/5 (0.24s)
    --- PASS: TestCheck/6 (0.28s)
    --- PASS: TestCheck/7 (0.29s)
=== RUN   TestCheckFsError
2026/11/11 03:26:41 DEBUG : Creating backend with remote "nonexistent"
2026/11/11 03:26:41 DEBUG : Creating backend with remote "nonexistent"
2026/11/11 03:26:41 DEBUG : Local file system at nonexistent: Waiting for checks to finish
2026/11/11 03:26:41 ERROR : Local file system at nonexistent: error reading source root directory: directory not found
2026/11/11 03:26:41 NOTICE: Local file system at nonexistent: 0 differences found
2026/11/11 03:26:41 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:26:43 DEBUG : rutabaga: md5 = 465e62beee1414c0eda0709ee251b168 OK
=== RUN   TestCheckDownload/1
=== RUN   TestCheckDownload/2
2026/11/11 03:26:46 DEBUG : empty space: md5 = e14ec52baab92ad2600703827eec6747 OK
=== RUN   TestCheckDownload/3
2026/11/11 03:26:49 DEBUG : potato2: md5 = 051d2230e1bdb64b6e0ca7dbdbdf7825 OK
=== RUN   TestCheckDownload/4
=== RUN   TestCheckDownload/5
2026/11/11 03:26:52 DEBUG : remotepotato: md5 = 4a3d6465160991b6f960e9560bc031e6 OK
=== RUN   TestCheckDownload/6
=== RUN   TestCheckDownload/7
--- PASS: TestCheckDownload (14.67s)
    --- PASS: TestCheckDownload/1 (0.92s)
    --- PASS: TestCheckDownload/2 (0.72s)
    --- PASS: TestCheckDownload/3 (0.84s)
    --- PASS: TestCheckDownload/4 (0.96s)
    --- PASS: TestCheckDownload/5 (0.85s)
    --- PASS: TestCheckDownload/6 (0.84s)
    --- PASS: TestCheckDownload/7 (0.75s)
=== RUN   TestCheckSizeOnly
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:26:57 DEBUG : rutabaga: md5 = 5bebdaddb9e7083d82ac334fee142919 OK
=== RUN   TestCheckSizeOnly/1
=== RUN   TestCheckSizeOnly/2
2026/11/11 03:27:00 DEBUG : empty space: md5 = 440442fe08c0b58418c37176c8e252ef OK
=== RUN   TestCheckSizeOnly/3
2026/11/11 03:27:01 DEBUG : potato2: md5 = d5b233fafc6b795af91d517b1242753c OK
=== RUN   TestCheckSizeOnly/4
=== RUN   TestCheckSizeOnly/5
2026/11/11 03:27:03 DEBUG : remotepotato: md5 = 8fb8e08785a9846351bc97c7c2bc545f OK
=== RUN   TestCheckSizeOnly/6
=== RUN   TestCheckSizeOnly/7
--- PASS: TestCheckSizeOnly (10.31s)
    --- PASS: TestCheckSizeOnly/1 (0.24s)
    --- PASS: TestCheckSizeOnly/2 (0.24s)
    --- PASS: TestCheckSizeOnly/3 (0.27s)
    --- PASS: TestCheckSizeOnly/4 (0.25s)
    --- PASS: TestCheckSizeOnly/5 (0.23s)
    --- PASS: TestCheckSizeOnly/6 (0.22s)
    --- PASS: TestCheckSizeOnly/7 (0.23s)
=== RUN   TestCheckEqualReaders
--- PASS: TestCheckEqualReaders (0.00s)
=== RUN   TestParseSumFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:27:08 DEBUG : test.sum: md5 = 298b6241cc9726aaa223c0f2919349a3 OK
2026/11/11 03:27:09 NOTICE: test.sum: improperly formatted checksum line 4
2026/11/11 03:27:09 NOTICE: test.sum: improperly formatted checksum line 5
2026/11/11 03:27:09 NOTICE: test.sum: improperly formatted checksum line 6
2026/11/11 03:27:09 NOTICE: test.sum: 2 warning(s) suppressed...
2026/11/11 03:27:10 DEBUG : test.sum: md5 = c581f9ea5d044f4af4078e1fce13d001 OK
2026/11/11 03:27:11 NOTICE: test.sum: improperly formatted checksum line 4
2026/11/11 03:27:11 NOTICE: test.sum: improperly formatted checksum line 5
2026/11/11 03:27:11 NOTICE: test.sum: improperly formatted checksum line 6
2026/11/11 03:27:11 NOTICE: test.sum: 2 warning(s) suppressed...
--- PASS: TestParseSumFile (5.37s)
=== RUN   TestCheckSum
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:27:12 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/data"
2026/11/11 03:27:12 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/vjrnln8ratgmqakfosrqe8espk"
    check_test.go:354: Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/data' lacks md5, skipping
--- SKIP: TestCheckSum (1.99s)
=== RUN   TestCheckSumDownload
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:27:14 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/data"
2026/11/11 03:27:14 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/vjrnln8ratgmqakfosrqe8espk"
2026/11/11 03:27:17 DEBUG : data/banana: md5 = 8bc4368d829641c673621bac41621602 OK
2026/11/11 03:27:19 DEBUG : test.sum: md5 = c032b76df58cd84fb8b5d4a457bc388a OK
=== RUN   TestCheckSumDownload/subtest1
2026/11/11 03:27:23 DEBUG : data/potato: md5 = e0ad279defe5479912ae6c0a9f34d8c8 OK
2026/11/11 03:27:24 DEBUG : test.sum: md5 = 5ffd0aa4a4b94c0564a04fe45e63b11b OK
=== RUN   TestCheckSumDownload/subtest2
2026/11/11 03:27:28 DEBUG : test.sum: md5 = 9640d9fe24cc984b8b7a848564fe1223 OK
=== RUN   TestCheckSumDownload/subtest3
2026/11/11 03:27:31 DEBUG : test.sum: md5 = 0219241ded19d19f830efb2c29f3f425 OK
=== RUN   TestCheckSumDownload/subtest4
2026/11/11 03:27:35 DEBUG : test.sum: md5 = a5bb47e524d9142db0e9432b97b14387 OK
=== RUN   TestCheckSumDownload/subtest5
2026/11/11 03:27:39 DEBUG : test.sum: md5 = 213123b2511a40bc957247daade23894 OK
=== RUN   TestCheckSumDownload/subtest6
2026/11/11 03:27:42 DEBUG : data/banana: md5 = a24797d29c493c66f8eb3b882724f4b4 OK
2026/11/11 03:27:44 DEBUG : data/potato: md5 = fb97768a46d050ae32e2ab3b3d00febb OK
2026/11/11 03:27:45 DEBUG : test.sum: md5 = 428c43538e7d93e4f84601cc772b3a1a OK
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (36.76s)
    --- PASS: TestCheckSumDownload/subtest1 (2.23s)
    --- PASS: TestCheckSumDownload/subtest2 (1.90s)
    --- PASS: TestCheckSumDownload/subtest3 (1.82s)
    --- PASS: TestCheckSumDownload/subtest4 (1.74s)
    --- PASS: TestCheckSumDownload/subtest5 (1.75s)
    --- PASS: TestCheckSumDownload/subtest6 (1.70s)
    --- PASS: TestCheckSumDownload/subtest7 (2.05s)
=== RUN   TestCheckSumConcurrency
2026/11/11 03:27:50 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK
2026/11/11 03:27:50 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK
2026/11/11 03:27:50 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK
2026/11/11 03:27:50 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK
2026/11/11 03:27:50 NOTICE: Mock file system at checkSum: 0 differences found
2026/11/11 03:27:50 NOTICE: Mock file system at checkSum: 4 matching files
--- PASS: TestCheckSumConcurrency (0.00s)
=== RUN   TestCheckSumDownloadConcurrency
2026/11/11 03:27:50 DEBUG : file0: md5 = 022eb0c0085c731f335df970fafa7446 OK
2026/11/11 03:27:50 DEBUG : file2: md5 = a58f09ae3db8ae4b943fdbaace096072 OK
2026/11/11 03:27:50 DEBUG : file1: md5 = 17fbabbccbdea0e6be9eb64c8c6fea41 OK
2026/11/11 03:27:50 DEBUG : file3: md5 = e0639b17e0744aca9a3ba29c049e59ee OK
2026/11/11 03:27:50 NOTICE: Mock file system at checkSum: 0 differences found
2026/11/11 03:27:50 NOTICE: Mock file system at checkSum: 4 matching files
--- PASS: TestCheckSumDownloadConcurrency (0.00s)
=== RUN   TestApplyTransforms
2026/11/11 03:27:50 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-jayufas0cali"
2026/11/11 03:27:50 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:27:51 DEBUG : Creating backend with remote "TestDrive:crypt/b55lnckins3bli2mn0vdcbl5atas5tdmos9sp383ticg1imamh6g"
2026/11/11 03:27:52 DEBUG : Creating backend with remote "/tmp/rclone2928084072"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-jayufas0cali'", Local "Local file system at /tmp/rclone2928084072", Modify Window "1ms"
2026/11/11 03:27:54 DEBUG : hello, world!: md5 = 81abbf5673c742a770802dd5c9e9a969 OK
upper checkfile vs. lower remote (without normalization)
2026/11/11 03:27:54 ERROR : hello, world!: sum not found
2026/11/11 03:27:54 ERROR : HELLO, WORLD!: file not in Encrypted drive 'TestCryptDrive:rclone-test-jayufas0cali'
2026/11/11 03:27:54 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jayufas0cali': 1 files missing
2026/11/11 03:27:54 NOTICE: 1 hashes missing
2026/11/11 03:27:54 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jayufas0cali': 1 differences found
2026/11/11 03:27:54 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jayufas0cali': 2 errors while checking
upper checkfile vs. lower remote (with normalization)
2026/11/11 03:27:55 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:27:55 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jayufas0cali': 0 differences found
2026/11/11 03:27:55 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-jayufas0cali': 1 matching files
2026/11/11 03:27:55 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-havedep6wogo"
2026/11/11 03:27:55 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:27:55 DEBUG : Creating backend with remote "TestDrive:crypt/7c9a2u3bi9dh4fos25332o4db62lujnoq8p9oaf2r2tle6l9dk90"
2026/11/11 03:27:56 DEBUG : Creating backend with remote "/tmp/rclone2482976798"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-havedep6wogo'", Local "Local file system at /tmp/rclone2482976798", Modify Window "1ms"
2026/11/11 03:27:59 DEBUG : HELLO, WORLD!: md5 = 001db9edc6bbcf1039cbe37de8f1109c OK
lower checkfile vs. upper remote (without normalization)
2026/11/11 03:27:59 ERROR : HELLO, WORLD!: sum not found
2026/11/11 03:27:59 ERROR : hello, world!: file not in Encrypted drive 'TestCryptDrive:rclone-test-havedep6wogo'
2026/11/11 03:27:59 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-havedep6wogo': 1 files missing
2026/11/11 03:27:59 NOTICE: 1 hashes missing
2026/11/11 03:27:59 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-havedep6wogo': 1 differences found
2026/11/11 03:27:59 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-havedep6wogo': 2 errors while checking
lower checkfile vs. upper remote (with normalization)
2026/11/11 03:28:00 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:28:00 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-havedep6wogo': 0 differences found
2026/11/11 03:28:00 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-havedep6wogo': 1 matching files
2026/11/11 03:28:00 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-yabedor4josu"
2026/11/11 03:28:00 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:28:00 DEBUG : Creating backend with remote "TestDrive:crypt/hngh7qc0cahck6lpp9bptun0g2sjht6ebutk87u1djgprrd20370"
2026/11/11 03:28:01 DEBUG : Creating backend with remote "/tmp/rclone3589696930"
2026/11/11 03:28:01 DEBUG : Config file has changed externally - reloading
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-yabedor4josu'", Local "Local file system at /tmp/rclone3589696930", Modify Window "1ms"
2026/11/11 03:28:03 DEBUG : HeLlO, wOrLd!: md5 = 579dfa64e910b1377b499406676866b6 OK
lower checkfile vs. upperlowermixed remote (without normalization)
2026/11/11 03:28:04 ERROR : HeLlO, wOrLd!: sum not found
2026/11/11 03:28:04 ERROR : hello, world!: file not in Encrypted drive 'TestCryptDrive:rclone-test-yabedor4josu'
2026/11/11 03:28:04 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-yabedor4josu': 1 files missing
2026/11/11 03:28:04 NOTICE: 1 hashes missing
2026/11/11 03:28:04 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-yabedor4josu': 1 differences found
2026/11/11 03:28:04 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-yabedor4josu': 2 errors while checking
lower checkfile vs. upperlowermixed remote (with normalization)
2026/11/11 03:28:04 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:28:04 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-yabedor4josu': 0 differences found
2026/11/11 03:28:04 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-yabedor4josu': 1 matching files
2026/11/11 03:28:04 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-davepem2sesa"
2026/11/11 03:28:04 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:28:05 DEBUG : Creating backend with remote "TestDrive:crypt/bqueod3tv6275ua5mjfgetmhepsdg57a3lc7qsmmasqmpeqiql50"
2026/11/11 03:28:06 DEBUG : Creating backend with remote "/tmp/rclone4207201588"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-davepem2sesa'", Local "Local file system at /tmp/rclone4207201588", Modify Window "1ms"
2026/11/11 03:28:08 DEBUG : HELLO, WORLD!: md5 = 8889181a0cc182c9aa30e9d5ce253fc9 OK
upperlowermixed checkfile vs. upper remote (without normalization)
2026/11/11 03:28:08 ERROR : HELLO, WORLD!: sum not found
2026/11/11 03:28:08 ERROR : HeLlO, wOrLd!: file not in Encrypted drive 'TestCryptDrive:rclone-test-davepem2sesa'
2026/11/11 03:28:08 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-davepem2sesa': 1 files missing
2026/11/11 03:28:08 NOTICE: 1 hashes missing
2026/11/11 03:28:08 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-davepem2sesa': 1 differences found
2026/11/11 03:28:08 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-davepem2sesa': 2 errors while checking
upperlowermixed checkfile vs. upper remote (with normalization)
2026/11/11 03:28:09 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:28:09 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-davepem2sesa': 0 differences found
2026/11/11 03:28:09 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-davepem2sesa': 1 matching files
2026/11/11 03:28:09 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-gesacom1hoje"
2026/11/11 03:28:09 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:28:09 DEBUG : Creating backend with remote "TestDrive:crypt/cb4004nd992hcp0ta2tvv2lomapml9s5ijlu9qbo6rcj20n36ccg"
2026/11/11 03:28:10 DEBUG : Creating backend with remote "/tmp/rclone1879274370"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-gesacom1hoje'", Local "Local file system at /tmp/rclone1879274370", Modify Window "1ms"
2026/11/11 03:28:12 DEBUG : 測試_Русский___ě_áñ: md5 = f1cdf07dc5361c14c357259ce239c7d6 OK
NFD checkfile vs. NFC remote (without normalization)
2026/11/11 03:28:13 ERROR : 測試_Русский___ě_áñ: sum not found
2026/11/11 03:28:13 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-gesacom1hoje'
2026/11/11 03:28:13 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gesacom1hoje': 1 files missing
2026/11/11 03:28:13 NOTICE: 1 hashes missing
2026/11/11 03:28:13 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gesacom1hoje': 1 differences found
2026/11/11 03:28:13 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gesacom1hoje': 2 errors while checking
NFD checkfile vs. NFC remote (with normalization)
2026/11/11 03:28:13 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:28:13 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gesacom1hoje': 0 differences found
2026/11/11 03:28:13 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-gesacom1hoje': 1 matching files
2026/11/11 03:28:13 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-mawakow9goha"
2026/11/11 03:28:13 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:28:13 DEBUG : Creating backend with remote "TestDrive:crypt/ob5dlnn22kub9a0ddb6qsuoj57mo31duc68q8n5p5kll2frjssr0"
2026/11/11 03:28:15 DEBUG : Creating backend with remote "/tmp/rclone3295052456"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-mawakow9goha'", Local "Local file system at /tmp/rclone3295052456", Modify Window "1ms"
2026/11/11 03:28:17 DEBUG : 測試_Русский___ě_áñ: md5 = 9947fe263a6b470ae8679cacfc8c1302 OK
NFC checkfile vs. NFD remote (without normalization)
2026/11/11 03:28:17 ERROR : 測試_Русский___ě_áñ: sum not found
2026/11/11 03:28:17 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-mawakow9goha'
2026/11/11 03:28:17 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mawakow9goha': 1 files missing
2026/11/11 03:28:17 NOTICE: 1 hashes missing
2026/11/11 03:28:17 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mawakow9goha': 1 differences found
2026/11/11 03:28:17 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mawakow9goha': 2 errors while checking
NFC checkfile vs. NFD remote (with normalization)
2026/11/11 03:28:18 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:28:18 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mawakow9goha': 0 differences found
2026/11/11 03:28:18 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-mawakow9goha': 1 matching files
2026/11/11 03:28:18 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-hifuxoc3ragi"
2026/11/11 03:28:18 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:28:18 DEBUG : Creating backend with remote "TestDrive:crypt/lqbrqdl1ucg53hfhi3mbkjh9l42j8hta7sln9pnfalm8938mf4vg"
2026/11/11 03:28:19 DEBUG : Creating backend with remote "/tmp/rclone1934085615"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-hifuxoc3ragi'", Local "Local file system at /tmp/rclone1934085615", Modify Window "1ms"
2026/11/11 03:28:21 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 4fce9a84275d19a88440cff5c241c8e5 OK
NFDx2 checkfile vs. both remote (without normalization)
2026/11/11 03:28:22 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/11/11 03:28:22 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-hifuxoc3ragi'
2026/11/11 03:28:22 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hifuxoc3ragi': 1 files missing
2026/11/11 03:28:22 NOTICE: 1 hashes missing
2026/11/11 03:28:22 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hifuxoc3ragi': 1 differences found
2026/11/11 03:28:22 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hifuxoc3ragi': 2 errors while checking
NFDx2 checkfile vs. both remote (with normalization)
2026/11/11 03:28:23 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:28:23 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hifuxoc3ragi': 0 differences found
2026/11/11 03:28:23 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-hifuxoc3ragi': 1 matching files
2026/11/11 03:28:23 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-rerezaj7japo"
2026/11/11 03:28:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:28:23 DEBUG : Creating backend with remote "TestDrive:crypt/rf24rnseqr28ha4d6nkpj6t9bmrnjbj3s4d7r3f3qknear64ru1g"
2026/11/11 03:28:24 DEBUG : Creating backend with remote "/tmp/rclone3064458905"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-rerezaj7japo'", Local "Local file system at /tmp/rclone3064458905", Modify Window "1ms"
2026/11/11 03:28:26 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 30f9e09767437c1a72c9571cd28b1a7c OK
NFCx2 checkfile vs. both remote (without normalization)
2026/11/11 03:28:27 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/11/11 03:28:27 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-rerezaj7japo'
2026/11/11 03:28:27 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rerezaj7japo': 1 files missing
2026/11/11 03:28:27 NOTICE: 1 hashes missing
2026/11/11 03:28:27 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rerezaj7japo': 1 differences found
2026/11/11 03:28:27 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rerezaj7japo': 2 errors while checking
NFCx2 checkfile vs. both remote (with normalization)
2026/11/11 03:28:28 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:28:28 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rerezaj7japo': 0 differences found
2026/11/11 03:28:28 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-rerezaj7japo': 1 matching files
2026/11/11 03:28:28 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-vovosep4hate"
2026/11/11 03:28:28 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:28:28 DEBUG : Creating backend with remote "TestDrive:crypt/2k4a8i4hrpkh9ksppd643tv4bhd9h3oot6rvgs5h1noftb9vssp0"
2026/11/11 03:28:28 DEBUG : Creating backend with remote "/tmp/rclone3833181635"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-vovosep4hate'", Local "Local file system at /tmp/rclone3833181635", Modify Window "1ms"
2026/11/11 03:28:31 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 96860ad49dad6c306d071cac90604039 OK
both checkfile vs. NFDx2 remote (without normalization)
2026/11/11 03:28:31 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/11/11 03:28:31 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-vovosep4hate'
2026/11/11 03:28:31 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-vovosep4hate': 1 files missing
2026/11/11 03:28:31 NOTICE: 1 hashes missing
2026/11/11 03:28:31 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-vovosep4hate': 1 differences found
2026/11/11 03:28:31 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-vovosep4hate': 2 errors while checking
both checkfile vs. NFDx2 remote (with normalization)
2026/11/11 03:28:32 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:28:32 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-vovosep4hate': 0 differences found
2026/11/11 03:28:32 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-vovosep4hate': 1 matching files
2026/11/11 03:28:32 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-fapoqul9luti"
2026/11/11 03:28:32 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:28:32 DEBUG : Creating backend with remote "TestDrive:crypt/srilsjkcq0vtpardui8r27ppoach8213keqm7t47aaq762hg4isg"
2026/11/11 03:28:33 DEBUG : Creating backend with remote "/tmp/rclone439359571"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-fapoqul9luti'", Local "Local file system at /tmp/rclone439359571", Modify Window "1ms"
2026/11/11 03:28:35 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 8717bd271eb7bfe89c3cb7a796a931ce OK
both checkfile vs. NFCx2 remote (without normalization)
2026/11/11 03:28:36 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found
2026/11/11 03:28:36 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptDrive:rclone-test-fapoqul9luti'
2026/11/11 03:28:36 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-fapoqul9luti': 1 files missing
2026/11/11 03:28:36 NOTICE: 1 hashes missing
2026/11/11 03:28:36 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-fapoqul9luti': 1 differences found
2026/11/11 03:28:36 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-fapoqul9luti': 2 errors while checking
both checkfile vs. NFCx2 remote (with normalization)
2026/11/11 03:28:37 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/11/11 03:28:37 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-fapoqul9luti': 0 differences found
2026/11/11 03:28:37 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-fapoqul9luti': 1 matching files
2026/11/11 03:28:37 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-fapoqul9luti': Purge remote
2026/11/11 03:28:37 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-vovosep4hate': Purge remote
2026/11/11 03:28:37 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-rerezaj7japo': Purge remote
2026/11/11 03:28:38 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-hifuxoc3ragi': Purge remote
2026/11/11 03:28:38 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-mawakow9goha': Purge remote
2026/11/11 03:28:39 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-gesacom1hoje': Purge remote
2026/11/11 03:28:39 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-davepem2sesa': Purge remote
2026/11/11 03:28:40 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-yabedor4josu': Purge remote
2026/11/11 03:28:40 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-havedep6wogo': Purge remote
2026/11/11 03:28:41 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-jayufas0cali': Purge remote
--- PASS: TestApplyTransforms (50.84s)
=== RUN   TestTruncateString
--- PASS: TestTruncateString (0.00s)
=== RUN   TestCopyFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:28:41 DEBUG : file1: Need to transfer - File not found at Destination
2026/11/11 03:28:44 DEBUG : sub/file2: md5 = 354857fad18f1ec6923349470740b4c3 OK
2026/11/11 03:28:44 DEBUG : sub/file2: size = 14 OK
2026/11/11 03:28:44 INFO  : file1: Copied (new) to: sub/file2
2026/11/11 03:28:44 DEBUG : sub/file2: size = 14 OK
2026/11/11 03:28:44 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/11 03:28:44 DEBUG : file1: Unchanged skipping
2026/11/11 03:28:45 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': don't need to copy/move sub/file2, it is already at target location
--- PASS: TestCopyFile (6.09s)
=== RUN   TestCopyFileImmutable
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:28:48 DEBUG : existing: Need to transfer - File not found at Destination
2026/11/11 03:28:49 DEBUG : existing: md5 = da10cdb3de84a80b1be167edacdde684 OK
2026/11/11 03:28:49 DEBUG : existing: size = 6 OK
2026/11/11 03:28:49 INFO  : existing: Copied (new)
2026/11/11 03:28:49 DEBUG : existing: size = 6 OK
2026/11/11 03:28:49 DEBUG : existing: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/11 03:28:49 DEBUG : existing: Unchanged skipping
2026/11/11 03:28:50 DEBUG : existing: size = 8 (Local file system at /tmp/rclone875949583)
2026/11/11 03:28:50 DEBUG : existing: size = 6 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka')
2026/11/11 03:28:50 DEBUG : existing: Sizes differ
2026/11/11 03:28:50 ERROR : existing: Source and destination exist but do not match: immutable file modified
--- PASS: TestCopyFileImmutable (3.77s)
=== RUN   TestCopyLongFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
    copy_test.go:188: Test only runs on local
--- SKIP: TestCopyLongFile (0.47s)
=== RUN   TestCopyFileBackupDir
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:28:54 DEBUG : dst/file1: md5 = 6bad039c682d0ef4b02dd0d4b1ebd537 OK
2026/11/11 03:28:55 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/backup"
2026/11/11 03:28:55 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/1nrff024r7pq65ecp72fc28jb0"
2026/11/11 03:28:56 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone875949583)
2026/11/11 03:28:56 DEBUG : dst/file1: size = 18 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka')
2026/11/11 03:28:56 DEBUG : dst/file1: Sizes differ
2026/11/11 03:28:59 INFO  : dst/file1: Moved (server-side)
2026/11/11 03:29:00 DEBUG : dst/file1: md5 = 63d8bf8d9d5b7711d57b089b4726f4e6 OK
2026/11/11 03:29:00 DEBUG : dst/file1: size = 14 OK
2026/11/11 03:29:00 INFO  : dst/file1: Copied (new)
--- PASS: TestCopyFileBackupDir (13.06s)
=== RUN   TestCopyFileCompareDest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:29:05 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/dst"
2026/11/11 03:29:05 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/31u3jie661vd5p8j7rtc3hgbh0"
2026/11/11 03:29:06 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/CompareDest"
2026/11/11 03:29:06 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/gveqi14airsml4bgu7krj116o8"
2026/11/11 03:29:08 DEBUG : one: Need to transfer - File not found at Destination
2026/11/11 03:29:10 DEBUG : one: md5 = d92c3f2fc7a64087490f6244e3271c0b OK
2026/11/11 03:29:10 DEBUG : one: size = 3 OK
2026/11/11 03:29:10 INFO  : one: Copied (new)
2026/11/11 03:29:12 DEBUG : one: size = 5 (Local file system at /tmp/rclone875949583)
2026/11/11 03:29:12 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/dst')
2026/11/11 03:29:12 DEBUG : one: Sizes differ
2026/11/11 03:29:13 DEBUG : one: md5 = 3c5bd6dda3e5999d6b6b06b95bb54edc OK
2026/11/11 03:29:13 DEBUG : one: size = 5 OK
2026/11/11 03:29:13 INFO  : one: Copied (replaced existing)
2026/11/11 03:29:16 DEBUG : dst/one: md5 = f7cfbd617a609cbd1ad921406b0f5582 OK
2026/11/11 03:29:18 DEBUG : CompareDest/one: md5 = 026cede312e4ae3f0000874ae69e00c9 OK
2026/11/11 03:29:18 DEBUG : one: size = 5 (Local file system at /tmp/rclone875949583)
2026/11/11 03:29:18 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/dst')
2026/11/11 03:29:18 DEBUG : one: Sizes differ
2026/11/11 03:29:19 DEBUG : one: size = 5 OK
2026/11/11 03:29:19 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/11 03:29:19 DEBUG : one: Destination found in --compare-dest, skipping
2026/11/11 03:29:21 DEBUG : CompareDest/two: md5 = 5dbcef44a06d75205fe6a527b581317c OK
2026/11/11 03:29:21 DEBUG : two: Need to transfer - File not found at Destination
2026/11/11 03:29:22 DEBUG : two: size = 3 OK
2026/11/11 03:29:22 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/11 03:29:22 DEBUG : two: Destination found in --compare-dest, skipping
2026/11/11 03:29:23 DEBUG : two: Need to transfer - File not found at Destination
2026/11/11 03:29:23 DEBUG : two: size = 3 OK
2026/11/11 03:29:23 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/11 03:29:23 DEBUG : two: Destination found in --compare-dest, skipping
2026/11/11 03:29:24 DEBUG : two: Need to transfer - File not found at Destination
2026/11/11 03:29:24 DEBUG : two: size = 5 (Local file system at /tmp/rclone875949583)
2026/11/11 03:29:24 DEBUG : two: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/CompareDest')
2026/11/11 03:29:24 DEBUG : two: Sizes differ
2026/11/11 03:29:26 DEBUG : two: md5 = 6780b6dc811171236b32cdf1dee02448 OK
2026/11/11 03:29:26 DEBUG : two: size = 5 OK
2026/11/11 03:29:26 INFO  : two: Copied (new)
--- PASS: TestCopyFileCompareDest (25.91s)
=== RUN   TestCopyFileCopyDestImmutable
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:29:31 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/dst"
2026/11/11 03:29:31 DEBUG : Config file has changed externally - reloading
2026/11/11 03:29:31 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/31u3jie661vd5p8j7rtc3hgbh0"
2026/11/11 03:29:34 DEBUG : dst/one: md5 = 147ca044068d08c4cd03d321c1e6e4b6 OK
2026/11/11 03:29:36 DEBUG : CopyDest/one: md5 = eb61793fd3c0b0ec1a7fb8890ef8ba2f OK
2026/11/11 03:29:37 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/CopyDest"
2026/11/11 03:29:37 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/d09o6po3f7bm6ce32vdgs8h9ls"
2026/11/11 03:29:38 DEBUG : one: size = 5 (Local file system at /tmp/rclone875949583)
2026/11/11 03:29:38 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/dst')
2026/11/11 03:29:38 DEBUG : one: Sizes differ
2026/11/11 03:29:38 DEBUG : one: size = 5 OK
2026/11/11 03:29:38 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/11 03:29:38 DEBUG : one: size = 5 (Local file system at /tmp/rclone875949583)
2026/11/11 03:29:38 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/dst')
2026/11/11 03:29:38 DEBUG : one: Sizes differ
2026/11/11 03:29:38 ERROR : one: Source and destination exist but do not match: immutable file modified
--- PASS: TestCopyFileCopyDestImmutable (11.58s)
=== RUN   TestCopyFileCopyDest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:29:42 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/dst"
2026/11/11 03:29:42 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/31u3jie661vd5p8j7rtc3hgbh0"
2026/11/11 03:29:44 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/CopyDest"
2026/11/11 03:29:44 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/d09o6po3f7bm6ce32vdgs8h9ls"
2026/11/11 03:29:45 DEBUG : one: Need to transfer - File not found at Destination
2026/11/11 03:29:48 DEBUG : one: md5 = 9c418ec30e1e6dffbb27496135835443 OK
2026/11/11 03:29:48 DEBUG : one: size = 3 OK
2026/11/11 03:29:48 INFO  : one: Copied (new)
2026/11/11 03:29:49 DEBUG : one: size = 5 (Local file system at /tmp/rclone875949583)
2026/11/11 03:29:49 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/dst')
2026/11/11 03:29:49 DEBUG : one: Sizes differ
2026/11/11 03:29:50 DEBUG : one: md5 = 30bc092ae1a855370a7b0ea513816a0a OK
2026/11/11 03:29:50 DEBUG : one: size = 5 OK
2026/11/11 03:29:50 INFO  : one: Copied (replaced existing)
2026/11/11 03:29:52 DEBUG : dst/one: md5 = 770e4577076b808f9d94cb93ed7c0621 OK
2026/11/11 03:29:54 DEBUG : CopyDest/one: md5 = 4943e006f377ed9ef4735441d2031179 OK
2026/11/11 03:29:55 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/BackupDir"
2026/11/11 03:29:55 DEBUG : Config file has changed externally - reloading
2026/11/11 03:29:55 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/s6dbk3lfi7c9kfvo6j7bla9m0g"
2026/11/11 03:29:56 DEBUG : one: size = 5 (Local file system at /tmp/rclone875949583)
2026/11/11 03:29:56 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/dst')
2026/11/11 03:29:56 DEBUG : one: Sizes differ
2026/11/11 03:29:57 DEBUG : one: size = 5 OK
2026/11/11 03:29:57 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/11 03:29:57 DEBUG : one: size = 5 (Local file system at /tmp/rclone875949583)
2026/11/11 03:29:57 DEBUG : one: size = 3 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/dst')
2026/11/11 03:29:57 DEBUG : one: Sizes differ
2026/11/11 03:29:59 INFO  : one: Moved (server-side)
2026/11/11 03:30:00 DEBUG : one: size = 5 OK
2026/11/11 03:30:00 INFO  : one: Copied (server-side copy)
2026/11/11 03:30:00 DEBUG : one: Destination found in --copy-dest, using server-side copy
2026/11/11 03:30:01 DEBUG : CopyDest/two: md5 = 72783860d93024a2272f499303955017 OK
2026/11/11 03:30:02 DEBUG : two: Need to transfer - File not found at Destination
2026/11/11 03:30:02 DEBUG : two: size = 3 OK
2026/11/11 03:30:02 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/11 03:30:04 DEBUG : two: size = 3 OK
2026/11/11 03:30:04 INFO  : two: Copied (server-side copy)
2026/11/11 03:30:04 DEBUG : two: Destination found in --copy-dest, using server-side copy
2026/11/11 03:30:04 DEBUG : two: size = 3 OK
2026/11/11 03:30:04 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms)
2026/11/11 03:30:04 DEBUG : two: Unchanged skipping
2026/11/11 03:30:06 DEBUG : CopyDest/three: md5 = c5644d51926754c226fe957bd7f55285 OK
2026/11/11 03:30:07 DEBUG : three: Need to transfer - File not found at Destination
2026/11/11 03:30:07 DEBUG : three: size = 7 (Local file system at /tmp/rclone875949583)
2026/11/11 03:30:07 DEBUG : three: size = 5 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka/CopyDest')
2026/11/11 03:30:07 DEBUG : three: Sizes differ
2026/11/11 03:30:07 DEBUG : three: Destination not found in --copy-dest
2026/11/11 03:30:09 DEBUG : three: md5 = e8047f220a98f2de8fc9e003175ff097 OK
2026/11/11 03:30:09 DEBUG : three: size = 7 OK
2026/11/11 03:30:09 INFO  : three: Copied (new)
--- PASS: TestCopyFileCopyDest (33.28s)
=== RUN   TestCopyInplace
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
    copy_test.go:434: Partial uploads not supported
--- SKIP: TestCopyInplace (0.42s)
=== RUN   TestCopyLongFileName
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
    copy_test.go:467: Partial uploads not supported
--- SKIP: TestCopyLongFileName (0.46s)
=== RUN   TestCopyLongFileNameCollision
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
    copy_test.go:500: Partial uploads not supported
--- SKIP: TestCopyLongFileNameCollision (0.43s)
=== RUN   TestCopyFileMaxTransfer
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:30:17 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination
2026/11/11 03:30:19 DEBUG : TestCopyFileMaxTransfer/file1: md5 = cb4d5ae61b1ed6494efff53552b99d5d OK
2026/11/11 03:30:19 DEBUG : TestCopyFileMaxTransfer/file1: size = 14 OK
2026/11/11 03:30:19 INFO  : TestCopyFileMaxTransfer/file1: Copied (new)
2026/11/11 03:30:20 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination
2026/11/11 03:30:20 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/11 03:30:21 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination
2026/11/11 03:30:22 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination
2026/11/11 03:30:23 DEBUG : TestCopyFileMaxTransfer/file4: md5 = 76ae5af6a68b705e3cd41033af496c02 OK
2026/11/11 03:30:23 DEBUG : TestCopyFileMaxTransfer/file4: size = 2062 OK
2026/11/11 03:30:23 INFO  : TestCopyFileMaxTransfer/file4: Copied (new)
--- PASS: TestCopyFileMaxTransfer (9.28s)
=== RUN   TestDeduplicateInteractive
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
    dedupe_test.go:37: Can't run this test without a hash
--- SKIP: TestDeduplicateInteractive (0.54s)
=== RUN   TestDeduplicateSkip
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:30:29 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Looking for duplicate names using skip mode.
2026/11/11 03:30:30 NOTICE: one: Found 2 files with duplicate names
2026/11/11 03:30:30 NOTICE: one: Skipping 2 files with duplicate names
--- PASS: TestDeduplicateSkip (4.50s)
=== RUN   TestDeduplicateSizeOnly
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:30:35 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Looking for duplicate names using skip mode.
2026/11/11 03:30:35 NOTICE: one: Found 3 files with duplicate names
2026/11/11 03:30:35 NOTICE: one: Deleting 1/2 identical duplicates (size 11)
2026/11/11 03:30:36 INFO  : one: Deleted
2026/11/11 03:30:36 NOTICE: one: Skipping 2 files with duplicate names
--- PASS: TestDeduplicateSizeOnly (6.37s)
=== RUN   TestDeduplicateFirst
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:30:41 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Looking for duplicate names using first mode.
2026/11/11 03:30:42 NOTICE: one: Found 3 files with duplicate names
2026/11/11 03:30:42 INFO  : one: Deleted
2026/11/11 03:30:43 INFO  : one: Deleted
2026/11/11 03:30:43 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateFirst (6.47s)
=== RUN   TestDeduplicateNewest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:30:48 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Looking for duplicate names using newest mode.
2026/11/11 03:30:48 NOTICE: one: Found 3 files with duplicate names
2026/11/11 03:30:48 INFO  : one: Deleted
2026/11/11 03:30:49 INFO  : one: Deleted
2026/11/11 03:30:49 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateNewest (6.01s)
=== RUN   TestDeduplicateNewestByHash
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
    dedupe_test.go:37: Can't run this test without a hash
--- SKIP: TestDeduplicateNewestByHash (0.65s)
=== RUN   TestDeduplicateOldest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:30:54 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Looking for duplicate names using oldest mode.
2026/11/11 03:30:55 NOTICE: one: Found 3 files with duplicate names
2026/11/11 03:30:55 INFO  : one: Deleted
2026/11/11 03:30:56 INFO  : one: Deleted
2026/11/11 03:30:56 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateOldest (6.70s)
=== RUN   TestDeduplicateLargest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:31:01 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Looking for duplicate names using largest mode.
2026/11/11 03:31:02 NOTICE: one: Found 3 files with duplicate names
2026/11/11 03:31:02 INFO  : one: Deleted
2026/11/11 03:31:03 INFO  : one: Deleted
2026/11/11 03:31:03 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateLargest (7.10s)
=== RUN   TestDeduplicateSmallest
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:31:08 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Looking for duplicate names using smallest mode.
2026/11/11 03:31:09 NOTICE: one: Found 3 files with duplicate names
2026/11/11 03:31:09 INFO  : one: Deleted
2026/11/11 03:31:10 INFO  : one: Deleted
2026/11/11 03:31:10 NOTICE: one: Deleted 2 extra copies
--- PASS: TestDeduplicateSmallest (6.69s)
=== RUN   TestDeduplicateRename
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:31:16 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Looking for duplicate names using rename mode.
2026/11/11 03:31:16 NOTICE: one.txt: Found 3 files with duplicate names
2026/11/11 03:31:17 INFO  : one-2.txt: renamed from: one.txt
2026/11/11 03:31:18 INFO  : one-3.txt: renamed from: one.txt
2026/11/11 03:31:19 INFO  : one-4.txt: renamed from: one.txt
--- PASS: TestDeduplicateRename (10.48s)
=== RUN   TestDeduplicateRenameManyExisting
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:31:23 DEBUG : one-1.txt: md5 = c6743bc89afe934f60c7646c04750ce1 OK
2026/11/11 03:31:24 DEBUG : one-2.txt: md5 = 3a200f6c5920731c61e6b95f80499bf2 OK
2026/11/11 03:31:26 DEBUG : one-3.txt: md5 = 80c36b5881a7a539378714553e382b17 OK
2026/11/11 03:31:27 DEBUG : one-4.txt: md5 = da96d20a289632bce0082f22fa1ac31f OK
2026/11/11 03:31:29 DEBUG : one-5.txt: md5 = ddd43ab5718e66e4c3ed2ab48a21e161 OK
2026/11/11 03:31:30 DEBUG : one-6.txt: md5 = 7fe7d184bc19956d8f9153197ca97bf6 OK
2026/11/11 03:31:31 DEBUG : one-7.txt: md5 = b6c3805b98a937b5d335e0fccb8631f3 OK
2026/11/11 03:31:33 DEBUG : one-8.txt: md5 = 2ac4c227411ca93ce8138af71d95eb1f OK
2026/11/11 03:31:34 DEBUG : one-9.txt: md5 = a18bad663cad014be0d8ec5c800e7b0f OK
2026/11/11 03:31:36 DEBUG : one-10.txt: md5 = 1afc253f615c61f245e60798b9b4b1f3 OK
2026/11/11 03:31:37 DEBUG : one-11.txt: md5 = 6cf21cd96fe308f22fa273c30f10ee59 OK
2026/11/11 03:31:39 DEBUG : one-12.txt: md5 = ecd1f1c8e8a529d75aca88ecde4b1f28 OK
2026/11/11 03:31:40 DEBUG : one-13.txt: md5 = f841d92573456504abed8e35c230d981 OK
2026/11/11 03:31:42 DEBUG : one-14.txt: md5 = f410fe0b276e62f6eb33b6e3411bf470 OK
2026/11/11 03:31:43 DEBUG : one-15.txt: md5 = f2cd180f9908557984eb2fe0e36fba72 OK
2026/11/11 03:31:44 DEBUG : one-16.txt: md5 = 3deff77b928c690213598c7bc2e52220 OK
2026/11/11 03:31:46 DEBUG : one-17.txt: md5 = 5bd49822dd530ba53efdc53a8bc005f5 OK
2026/11/11 03:31:47 DEBUG : one-18.txt: md5 = 28b9eae97fb07485d99f0aa06dc34d03 OK
2026/11/11 03:31:49 DEBUG : one-19.txt: md5 = 3d38b745159a60cef8e467bf522f7e81 OK
2026/11/11 03:31:50 DEBUG : one-20.txt: md5 = d4a6613fb0ce4f763966366716972b5c OK
2026/11/11 03:31:52 DEBUG : one-21.txt: md5 = 55d8fcfea35198eaeab4294a2789c341 OK
2026/11/11 03:31:53 DEBUG : one-22.txt: md5 = 4818a9ea804cf455adf4ec357f61bd38 OK
2026/11/11 03:31:55 DEBUG : one-23.txt: md5 = c7b3a87fa19d39b9db550a5e256eba40 OK
2026/11/11 03:31:56 DEBUG : one-24.txt: md5 = ade7ed68211a5879b2b78cff1484154f OK
2026/11/11 03:31:58 DEBUG : one-25.txt: md5 = 8f7eba7fca6cdf98b5d9c3d00cf1d206 OK
2026/11/11 03:31:59 DEBUG : one-26.txt: md5 = 3836b719e00c0c660baa0fcfd2137733 OK
2026/11/11 03:32:00 DEBUG : one-27.txt: md5 = 37f48dbc6b0e631ced11af1f41c9f3dd OK
2026/11/11 03:32:02 DEBUG : one-28.txt: md5 = 1aaca5447db400945de82a9451c06acb OK
2026/11/11 03:32:03 DEBUG : one-29.txt: md5 = 848504b831a5e6049946c4d517aaf406 OK
2026/11/11 03:32:05 DEBUG : one-30.txt: md5 = 5b7ff8f4c8c2513dcb281600c724817b OK
2026/11/11 03:32:06 DEBUG : one-31.txt: md5 = 6f83b84339f254677f31d2be2a41f1b8 OK
2026/11/11 03:32:07 DEBUG : one-32.txt: md5 = 6c4fb02325a0ea509436a3b3b3903d87 OK
2026/11/11 03:32:09 DEBUG : one-33.txt: md5 = c1dab8ee0db0ff10ba496cdbddc40d81 OK
2026/11/11 03:32:10 DEBUG : one-34.txt: md5 = 68cfdaa1d7e4621132a545931c0fb88f OK
2026/11/11 03:32:11 DEBUG : one-35.txt: md5 = 07f043a0379ee9c964b7917ab293bf3c OK
2026/11/11 03:32:13 DEBUG : one-36.txt: md5 = 42303e12933760e521ed7d905556aad6 OK
2026/11/11 03:32:14 DEBUG : one-37.txt: md5 = b9545efebcf4a99d890eb7fa299a08cd OK
2026/11/11 03:32:16 DEBUG : one-38.txt: md5 = 8c4e84aa8b8a65c30e4131a5f8f7eae0 OK
2026/11/11 03:32:17 DEBUG : one-39.txt: md5 = 6e3a5fda4361557f52dc17eddcc3871a OK
2026/11/11 03:32:19 DEBUG : one-40.txt: md5 = faf5fba5bd5ff278b3944a5a2f05739f OK
2026/11/11 03:32:20 DEBUG : one-41.txt: md5 = d468f290804d79982f60b63071d40951 OK
2026/11/11 03:32:21 DEBUG : one-42.txt: md5 = fffba3419762a25d6f1cd1df9a529245 OK
2026/11/11 03:32:23 DEBUG : one-43.txt: md5 = 316f057edbc8c6117e81366637ecda62 OK
2026/11/11 03:32:24 DEBUG : one-44.txt: md5 = bb166f8acc7aa6194dc6231e07420625 OK
2026/11/11 03:32:26 DEBUG : one-45.txt: md5 = fab4f360d99329c765dbbbc14fd307d7 OK
2026/11/11 03:32:27 DEBUG : one-46.txt: md5 = 71859bd281febd65a003f7153b761c7c OK
2026/11/11 03:32:28 DEBUG : one-47.txt: md5 = cafe39ecd113477274d9aeec6d5f1858 OK
2026/11/11 03:32:30 DEBUG : one-48.txt: md5 = 7ae91fdd4c7722062b5a8e60dee1787a OK
2026/11/11 03:32:31 DEBUG : one-49.txt: md5 = c15a84194d2a523989a7e4cce70d88b7 OK
2026/11/11 03:32:33 DEBUG : one-50.txt: md5 = dfdf7ada12e237da69f6575c710c28c7 OK
2026/11/11 03:32:34 DEBUG : one-51.txt: md5 = 6d6760266a84f4e33cbe22a786575b6b OK
2026/11/11 03:32:36 DEBUG : one-52.txt: md5 = a8715f1b1747958d05b00c456a2344c3 OK
2026/11/11 03:32:37 DEBUG : one-53.txt: md5 = 79e435f148b1b81a6c401d350650121e OK
2026/11/11 03:32:38 DEBUG : one-54.txt: md5 = c72aa39ad6026d07343b8887887874f1 OK
2026/11/11 03:32:40 DEBUG : one-55.txt: md5 = eeb0699351ba5fa57ac84727913c2048 OK
2026/11/11 03:32:41 DEBUG : one-56.txt: md5 = 768c6f786e0c97b9459d2ebd616dbf56 OK
2026/11/11 03:32:42 DEBUG : one-57.txt: md5 = 9913d429cb9fd59c4b17a016e91613d3 OK
2026/11/11 03:32:44 DEBUG : one-58.txt: md5 = 375cd12872089a469a3dd13db1b7a9a0 OK
2026/11/11 03:32:45 DEBUG : one-59.txt: md5 = 936bf7bfcad48377cdea371b4eb2abdd OK
2026/11/11 03:32:46 DEBUG : one-60.txt: md5 = 90c309380b10afca117853312a3aa25b OK
2026/11/11 03:32:48 DEBUG : one-61.txt: md5 = d9235334a7f73a45440d3bd7c92ca03c OK
2026/11/11 03:32:49 DEBUG : one-62.txt: md5 = 45c26df53063f6b145bbf3642dbd117e OK
2026/11/11 03:32:50 DEBUG : one-63.txt: md5 = 237c7498add0fdef9be55fe383d32797 OK
2026/11/11 03:32:52 DEBUG : one-64.txt: md5 = 1840c56151abb53d3a669508cbb83d0c OK
2026/11/11 03:32:54 DEBUG : one-65.txt: md5 = 51df3966d13a70910603ae68d603dc14 OK
2026/11/11 03:32:55 DEBUG : one-66.txt: md5 = 1e28bff651cfaffbc9d704741abe502c OK
2026/11/11 03:32:56 DEBUG : one-67.txt: md5 = fd82b5f9560f15dfb263c7290a0a7145 OK
2026/11/11 03:32:58 DEBUG : one-68.txt: md5 = 3c725952f6d520d3a24fe693b4ec2306 OK
2026/11/11 03:32:59 DEBUG : one-69.txt: md5 = c4a1e46ec049d75e78fd48a03b02766a OK
2026/11/11 03:33:00 DEBUG : one-70.txt: md5 = ef50a2a77edb7a23a84517dede1b5f98 OK
2026/11/11 03:33:02 DEBUG : one-71.txt: md5 = b673213066e1398938d2dca281e1f2cf OK
2026/11/11 03:33:03 DEBUG : one-72.txt: md5 = a3e8fe8c271c04dce1e13c899752899e OK
2026/11/11 03:33:04 DEBUG : one-73.txt: md5 = 9de27e662fe1246fa7eaf6ce6fdf040b OK
2026/11/11 03:33:06 DEBUG : one-74.txt: md5 = 272042bd4ac27c1f4cb5095768f344ce OK
2026/11/11 03:33:07 DEBUG : one-75.txt: md5 = 4ed19ec2cef52563372c683c14aafbb5 OK
2026/11/11 03:33:09 DEBUG : one-76.txt: md5 = 909b898d8b6e7594a200e5375b5cf0e7 OK
2026/11/11 03:33:10 DEBUG : one-77.txt: md5 = 3f5708b3546c61abaebfc9e67e440ae9 OK
2026/11/11 03:33:11 DEBUG : one-78.txt: md5 = 8bbda11157ff4286aa02171c8d523b3f OK
2026/11/11 03:33:13 DEBUG : one-79.txt: md5 = 27c26282942cac33ee095178ce48c4e3 OK
2026/11/11 03:33:14 DEBUG : one-80.txt: md5 = d32a3b1a8fb40a379dbb74b87280a659 OK
2026/11/11 03:33:15 DEBUG : one-81.txt: md5 = 23c5a29dbaf12ae81aeb8166a87d221a OK
2026/11/11 03:33:17 DEBUG : one-82.txt: md5 = 97ec4c07649406501e02c227cbdaad5b OK
2026/11/11 03:33:18 DEBUG : one-83.txt: md5 = c34fe07369baf332b6ead77ddb994146 OK
2026/11/11 03:33:20 DEBUG : one-84.txt: md5 = dfee0ea4025e99593af1196f0e4a81f7 OK
2026/11/11 03:33:21 DEBUG : one-85.txt: md5 = 743fdcc8a57a4bad60131c2c361e901b OK
2026/11/11 03:33:23 DEBUG : one-86.txt: md5 = 86f52fbbbada1bcf8cc89d0fc0ad0ece OK
2026/11/11 03:33:24 DEBUG : one-87.txt: md5 = 991794010db9fc7ae4e4fe1a47efca96 OK
2026/11/11 03:33:26 DEBUG : one-88.txt: md5 = d3f166d0579e8ea42b10ca75969a24ca OK
2026/11/11 03:33:27 DEBUG : one-89.txt: md5 = ad490fabf0089393aa34bb159fbca33e OK
2026/11/11 03:33:28 DEBUG : one-90.txt: md5 = b1b3b8acb286c5ac69fd84a0128f8b18 OK
2026/11/11 03:33:30 DEBUG : one-91.txt: md5 = 8f7dd3cbb11d03c49ddf4995a39c2baf OK
2026/11/11 03:33:31 DEBUG : one-92.txt: md5 = dbfde94dd40421e0b47ee94ebd678aae OK
2026/11/11 03:33:32 DEBUG : one-93.txt: md5 = 72c37b4392f413628b4052ca79895501 OK
2026/11/11 03:33:34 DEBUG : one-94.txt: md5 = 33ccefed0c35c2b23c1678ac4327ae51 OK
2026/11/11 03:33:35 DEBUG : one-95.txt: md5 = b3d8b9a7b25d492e9b2f32b6a07b6014 OK
2026/11/11 03:33:37 DEBUG : one-96.txt: md5 = fc80c31a4d0a12f746464fcec0fcfccd OK
2026/11/11 03:33:38 DEBUG : one-97.txt: md5 = 00d204618ff8e8058a2525032f93bc2d OK
2026/11/11 03:33:39 DEBUG : one-98.txt: md5 = c28bd26e7dcfda3ebf11bb4c4cab8f0c OK
2026/11/11 03:33:40 DEBUG : one-99.txt: md5 = da09aeaf5be45afa16e09190b7932680 OK
2026/11/11 03:33:42 DEBUG : one-100.txt: md5 = a7e3b7850581defc48a114507ac71986 OK
2026/11/11 03:33:43 DEBUG : one-101.txt: md5 = a8bd9e5ddb463c4d6a58dc493aef7c29 OK
2026/11/11 03:33:45 DEBUG : one-102.txt: md5 = aa665bcabbe8c6a472f28cca3dd0b8da OK
2026/11/11 03:33:46 DEBUG : one-103.txt: md5 = d07d74190e2e224c9aea535a9c957200 OK
2026/11/11 03:33:47 DEBUG : one-104.txt: md5 = 6ca9ebbad8c20132979e119b390d7136 OK
2026/11/11 03:33:48 DEBUG : one-105.txt: md5 = cedd91230ccc126b67737b05c5e1c9eb OK
2026/11/11 03:33:51 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Looking for duplicate names using rename mode.
2026/11/11 03:33:52 NOTICE: one.txt: Found 2 files with duplicate names
2026/11/11 03:33:53 INFO  : one-106.txt: renamed from: one.txt
2026/11/11 03:33:53 INFO  : one-107.txt: renamed from: one.txt
--- PASS: TestDeduplicateRenameManyExisting (200.14s)
=== RUN   TestMergeDirs
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:34:44 DEBUG : dupe1/one.txt: md5 = b4d19ea93ba74e62430d0fb275f3eb71 OK
2026/11/11 03:34:46 DEBUG : dupe2/two.txt: md5 = 7fdfd3cd72b7b144d86977fc4da59ed3 OK
2026/11/11 03:34:48 DEBUG : dupe3/three.txt: md5 = ec51ad3c924770b4ec0f3c16cf426939 OK
2026/11/11 03:34:49 INFO  : urj8gsducqbtvekeq181ntd2u8: merging "sfrom47189m9qr3mt4qonu281c"
2026/11/11 03:34:49 INFO  : urj8gsducqbtvekeq181ntd2u8: removing empty directory
2026/11/11 03:34:50 INFO  : 1u1r4ei7c628fnjg9blqt3j60o: merging "tr2hj63d80ftlmvm6a952snjcc"
2026/11/11 03:34:51 INFO  : 1u1r4ei7c628fnjg9blqt3j60o: removing empty directory
--- PASS: TestMergeDirs (14.10s)
=== RUN   TestIndex
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:34:57 DEBUG : file1.txt: md5 = 03d9e0e8c992ae3a1ecefbe470c75629 OK
2026/11/11 03:34:59 DEBUG : sub/file2.txt: md5 = d4c000f4027a51e2920f8265927fd7f5 OK
2026/11/11 03:35:01 DEBUG : sub/deep/file3.txt: md5 = bd48501512acd7a622aeca9781e581db OK
2026/11/11 03:35:03 DEBUG : index.html: md5 = 2394e507945db3aa76c2ee3ad434c8fe OK
2026/11/11 03:35:03 DEBUG : index.html: size = 12147 OK
2026/11/11 03:35:03 INFO  : index.html: Copied (new)
2026/11/11 03:35:03 DEBUG : caddy.json: md5 = 83398968cc182399e9f074169897368e OK
2026/11/11 03:35:03 DEBUG : caddy.json: size = 259 OK
2026/11/11 03:35:03 INFO  : caddy.json: Copied (new)
2026/11/11 03:35:04 DEBUG : sub/deep/index.html: md5 = e927cc54cad5d1903c1954574b80810e OK
2026/11/11 03:35:04 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/11 03:35:04 INFO  : sub/deep/index.html: Copied (new)
2026/11/11 03:35:04 DEBUG : index.json: md5 = 771bfcaf6e699b9f584048c1709bcee4 OK
2026/11/11 03:35:04 DEBUG : index.json: size = 213 OK
2026/11/11 03:35:04 INFO  : index.json: Copied (new)
2026/11/11 03:35:05 DEBUG : sub/deep/index.json: md5 = 569c8bf1294c1195212eec97e5e508f8 OK
2026/11/11 03:35:05 DEBUG : sub/deep/index.json: size = 119 OK
2026/11/11 03:35:05 INFO  : sub/deep/index.json: Copied (new)
2026/11/11 03:35:05 DEBUG : sub/index.html: md5 = 3d20563f5beafb2ae97db31988e8b981 OK
2026/11/11 03:35:05 DEBUG : sub/index.html: size = 12306 OK
2026/11/11 03:35:05 INFO  : sub/index.html: Copied (new)
2026/11/11 03:35:05 DEBUG : sub/deep/caddy.json: md5 = c3b17f1220969f4177eb921622c51060 OK
2026/11/11 03:35:05 DEBUG : sub/deep/caddy.json: size = 131 OK
2026/11/11 03:35:05 INFO  : sub/deep/caddy.json: Copied (new)
2026/11/11 03:35:05 DEBUG : sub/index.json: md5 = 2c0e695e9b7f60f0153cbd0a7462a91a OK
2026/11/11 03:35:05 DEBUG : sub/index.json: size = 215 OK
2026/11/11 03:35:05 INFO  : sub/index.json: Copied (new)
2026/11/11 03:35:06 DEBUG : sub/caddy.json: md5 = 6ebb369a2eb76224ebe09690d256c016 OK
2026/11/11 03:35:06 DEBUG : sub/caddy.json: size = 261 OK
2026/11/11 03:35:06 INFO  : sub/caddy.json: Copied (new)
2026/11/11 03:35:12 DEBUG : index.html: Unchanged skipping
2026/11/11 03:35:12 DEBUG : sub/index.html: Unchanged skipping
2026/11/11 03:35:12 DEBUG : sub/deep/index.html: Unchanged skipping
2026/11/11 03:35:12 DEBUG : index.json: Unchanged skipping
2026/11/11 03:35:12 DEBUG : sub/index.json: Unchanged skipping
2026/11/11 03:35:12 DEBUG : sub/deep/index.json: Unchanged skipping
2026/11/11 03:35:13 DEBUG : caddy.json: Unchanged skipping
2026/11/11 03:35:13 DEBUG : sub/caddy.json: Unchanged skipping
2026/11/11 03:35:13 DEBUG : sub/deep/caddy.json: Unchanged skipping
2026/11/11 03:35:15 DEBUG : caddy.json: md5 = 0df245ca7610b8fbf4ca3f08e793133f OK
2026/11/11 03:35:15 DEBUG : caddy.json: size = 259 OK
2026/11/11 03:35:15 INFO  : caddy.json: Copied (replaced existing)
2026/11/11 03:35:15 DEBUG : sub/index.html: md5 = 00717ccb904f17c10e44ca8bb29bd73d OK
2026/11/11 03:35:15 DEBUG : sub/index.html: size = 12306 OK
2026/11/11 03:35:15 INFO  : sub/index.html: Copied (replaced existing)
2026/11/11 03:35:15 DEBUG : index.html: md5 = 9432b1228c07772fb0505f847281629f OK
2026/11/11 03:35:15 DEBUG : index.html: size = 12147 OK
2026/11/11 03:35:15 INFO  : index.html: Copied (replaced existing)
2026/11/11 03:35:15 DEBUG : index.json: md5 = cdbbebd12a34b4926d8e2c7a6ce7b9f0 OK
2026/11/11 03:35:15 DEBUG : index.json: size = 213 OK
2026/11/11 03:35:15 INFO  : index.json: Copied (replaced existing)
2026/11/11 03:35:16 DEBUG : sub/caddy.json: md5 = 3343408b6dc35722c668aa41908ab843 OK
2026/11/11 03:35:16 DEBUG : sub/caddy.json: size = 261 OK
2026/11/11 03:35:16 INFO  : sub/caddy.json: Copied (replaced existing)
2026/11/11 03:35:16 DEBUG : sub/index.json: md5 = 94dab32d424bac887041ec8c080f2164 OK
2026/11/11 03:35:16 DEBUG : sub/index.json: size = 215 OK
2026/11/11 03:35:16 INFO  : sub/index.json: Copied (replaced existing)
2026/11/11 03:35:16 DEBUG : sub/deep/index.html: md5 = 368b792bf719deebc011c0ed437a0016 OK
2026/11/11 03:35:16 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/11 03:35:16 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/11/11 03:35:16 DEBUG : sub/deep/index.json: md5 = 53deba4bbc368880f80d4cdbaecd1c26 OK
2026/11/11 03:35:16 DEBUG : sub/deep/index.json: size = 119 OK
2026/11/11 03:35:16 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/11/11 03:35:17 DEBUG : sub/deep/caddy.json: md5 = 342999a9123641f89f0326f69d4ed5c4 OK
2026/11/11 03:35:17 DEBUG : sub/deep/caddy.json: size = 131 OK
2026/11/11 03:35:17 INFO  : sub/deep/caddy.json: Copied (replaced existing)
2026/11/11 03:35:19 DEBUG : sub/deep/file4.txt: md5 = 95e74674e27eae69c94c880066332d0f OK
2026/11/11 03:35:20 DEBUG : sub/index.html: Unchanged skipping
2026/11/11 03:35:20 DEBUG : index.html: Unchanged skipping
2026/11/11 03:35:21 DEBUG : sub/deep/index.html: md5 = 5a095f0a40f7b954728fd6728bb06797 OK
2026/11/11 03:35:21 DEBUG : sub/deep/index.html: size = 12346 OK
2026/11/11 03:35:21 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/11/11 03:35:21 DEBUG : sub/deep/caddy.json: md5 = f9a17dca7f781277430f0615c0ba34a7 OK
2026/11/11 03:35:21 DEBUG : sub/deep/caddy.json: size = 260 OK
2026/11/11 03:35:21 INFO  : sub/deep/caddy.json: Copied (replaced existing)
2026/11/11 03:35:21 DEBUG : sub/deep/index.json: md5 = 4cc2fec371deb676f48b39453501ed06 OK
2026/11/11 03:35:21 DEBUG : sub/deep/index.json: size = 235 OK
2026/11/11 03:35:21 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/11/11 03:35:21 DEBUG : index.json: Unchanged skipping
2026/11/11 03:35:21 DEBUG : sub/index.json: Unchanged skipping
2026/11/11 03:35:22 DEBUG : caddy.json: Unchanged skipping
2026/11/11 03:35:22 DEBUG : sub/caddy.json: Unchanged skipping
2026/11/11 03:35:24 DEBUG : sub/deep/file5.txt: md5 = 2570d58bf285f754914270e87dd155dd OK
2026/11/11 03:35:25 NOTICE: sub/deep/index.html: Skipped copy as --dry-run is set (size 12.309Ki)
2026/11/11 03:35:25 NOTICE: sub/deep/caddy.json: Skipped copy as --dry-run is set (size 389)
2026/11/11 03:35:25 NOTICE: sub/deep/index.json: Skipped copy as --dry-run is set (size 351)
2026/11/11 03:35:25 DEBUG : index.html: Unchanged skipping
2026/11/11 03:35:25 DEBUG : sub/index.html: Unchanged skipping
2026/11/11 03:35:26 DEBUG : index.json: Unchanged skipping
2026/11/11 03:35:26 DEBUG : sub/index.json: Unchanged skipping
2026/11/11 03:35:26 DEBUG : caddy.json: Unchanged skipping
2026/11/11 03:35:27 DEBUG : sub/caddy.json: Unchanged skipping
--- PASS: TestIndex (40.26s)
=== RUN   TestIndexDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:35:37 DEBUG : file1.txt: md5 = af2c2c4364a00148e844d8dc00bd7139 OK
2026/11/11 03:35:40 DEBUG : sub/file2.txt: md5 = 1199a143c30d4ca5a06935e30cef2449 OK
2026/11/11 03:35:42 DEBUG : sub/deep/file3.txt: md5 = 87b1ce6dc7b1ca61ebbb64cda07419eb OK
2026/11/11 03:35:44 DEBUG : index.html: md5 = e3bef2fbf6b208b9f08c5e86c1175d19 OK
2026/11/11 03:35:44 DEBUG : index.html: size = 12147 OK
2026/11/11 03:35:44 INFO  : index.html: Copied (new)
2026/11/11 03:35:44 DEBUG : sub/index.html: md5 = be40cd462b728f6aa4881e98805e20dd OK
2026/11/11 03:35:44 DEBUG : sub/index.html: size = 12306 OK
2026/11/11 03:35:44 INFO  : sub/index.html: Copied (new)
2026/11/11 03:35:44 DEBUG : sub/deep/index.html: md5 = 509780c0db6335c7e3822d212b890317 OK
2026/11/11 03:35:44 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/11 03:35:44 INFO  : sub/deep/index.html: Copied (new)
2026/11/11 03:35:46 DEBUG : sub/index.html: Unchanged skipping
2026/11/11 03:35:46 DEBUG : index.html: Unchanged skipping
2026/11/11 03:35:47 DEBUG : sub/deep/index.html: md5 = 4ee0f45c91ea688387961828be241429 OK
2026/11/11 03:35:47 DEBUG : sub/deep/index.html: size = 11829 OK
2026/11/11 03:35:47 INFO  : sub/deep/index.html: Copied (replaced existing)
--- PASS: TestIndexDelete (17.90s)
=== RUN   TestIndexFilter
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:35:55 DEBUG : file1.txt: md5 = 613537014ffa2cf5d4c1ffa49607dcf4 OK
2026/11/11 03:35:57 DEBUG : sub/file2.txt: md5 = 2ae21d3471ee098b92684adf661a52da OK
2026/11/11 03:35:59 DEBUG : sub/deep/file3.txt: md5 = 1f10dfef902c1bedb09aeefbf5b2927e OK
2026/11/11 03:36:01 DEBUG : sub/deep/index.html: md5 = e8094f6ff0d2240641d7054618f48420 OK
2026/11/11 03:36:03 DEBUG : other/notes.md: md5 = 7f7f945b56bfad5d04d3bad0157bca8c OK
2026/11/11 03:36:04 DEBUG : other/notes.md: Excluded (Path Filter)
2026/11/11 03:36:05 DEBUG : other/index.html: md5 = 2859537ebe565e75e0e938028800bc2a OK
2026/11/11 03:36:05 DEBUG : other/index.html: size = 11802 OK
2026/11/11 03:36:05 INFO  : other/index.html: Copied (new)
2026/11/11 03:36:05 DEBUG : sub/index.html: md5 = e320c09d12d078255a4cd2de923df8fc OK
2026/11/11 03:36:05 DEBUG : sub/index.html: size = 12056 OK
2026/11/11 03:36:05 INFO  : sub/index.html: Copied (new)
2026/11/11 03:36:05 DEBUG : index.html: md5 = 632564afe1f715cb8bf322a800e2123f OK
2026/11/11 03:36:05 DEBUG : index.html: size = 12399 OK
2026/11/11 03:36:05 INFO  : index.html: Copied (new)
2026/11/11 03:36:10 DEBUG : other/notes.md: Excluded (Path Filter)
2026/11/11 03:36:11 DEBUG : sub/index.html: Unchanged skipping
2026/11/11 03:36:11 DEBUG : other/index.html: Unchanged skipping
2026/11/11 03:36:11 DEBUG : index.html: Unchanged skipping
--- PASS: TestIndexFilter (23.80s)
=== RUN   TestIndexRules
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:36:19 DEBUG : file1.txt: md5 = 169ee4910b39d2f437a0888648f0583e OK
2026/11/11 03:36:21 DEBUG : sub/file2.txt: md5 = 81d4dfb86357f2ebf0fef7543bc71e95 OK
2026/11/11 03:36:23 DEBUG : sub/deep/file3.txt: md5 = e47b1c20a1da7ed08e79c687ed355c44 OK
2026/11/11 03:36:25 DEBUG : sub/deep/index.html: md5 = 2a8178e00f17d96288c8f850a8bf1b86 OK
2026/11/11 03:36:27 DEBUG : sub/index.html: md5 = 4f32dab571f61ccae3c03a63d1f5078f OK
2026/11/11 03:36:27 DEBUG : sub/index.html: size = 12306 OK
2026/11/11 03:36:27 INFO  : sub/index.html: Copied (new)
2026/11/11 03:36:27 DEBUG : index.html: md5 = 70a75251e15812e2de4831fc7d72e6fa OK
2026/11/11 03:36:27 DEBUG : index.html: size = 12147 OK
2026/11/11 03:36:27 INFO  : index.html: Copied (new)
2026/11/11 03:36:32 DEBUG : sub/index.html: Unchanged skipping
2026/11/11 03:36:32 DEBUG : sub/deep/index.html: md5 = 34f48c455e74801e181e583c61929653 OK
2026/11/11 03:36:32 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/11 03:36:32 INFO  : sub/deep/index.html: Copied (replaced existing)
--- PASS: TestIndexRules (20.51s)
=== RUN   TestIndexMaxDepth
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:36:40 DEBUG : file1.txt: md5 = a9c0e5222f0f1611cc3ea5fa05262075 OK
2026/11/11 03:36:42 DEBUG : sub/file2.txt: md5 = 7728bffdec9086012f1ce6d536dc5021 OK
2026/11/11 03:36:44 DEBUG : sub/deep/file3.txt: md5 = 8c33b3516879ea3e42da125e1efdff0c OK
2026/11/11 03:36:46 DEBUG : index.html: md5 = 38b599fca4c9c7f3a7540f7af590b113 OK
2026/11/11 03:36:46 DEBUG : index.html: size = 12147 OK
2026/11/11 03:36:46 INFO  : index.html: Copied (new)
--- PASS: TestIndexMaxDepth (13.87s)
=== RUN   TestIndexLinkIndex
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:36:54 DEBUG : file1.txt: md5 = c95ba7d5424641eb24e819573cacdfb3 OK
2026/11/11 03:36:56 DEBUG : sub/file2.txt: md5 = cbc089f9f0e51efcd86cba96e9f92351 OK
2026/11/11 03:36:58 DEBUG : sub/deep/file3.txt: md5 = d428967ebdaca85d0d4e59d324447a56 OK
2026/11/11 03:37:00 DEBUG : index.html: md5 = 6def5545449021285015058d4f739fd3 OK
2026/11/11 03:37:00 DEBUG : index.html: size = 12167 OK
2026/11/11 03:37:00 INFO  : index.html: Copied (new)
2026/11/11 03:37:00 DEBUG : sub/index.html: md5 = 2b4337f01cbfb1b2b24962130bd35320 OK
2026/11/11 03:37:00 DEBUG : sub/index.html: size = 12347 OK
2026/11/11 03:37:00 INFO  : sub/index.html: Copied (new)
2026/11/11 03:37:00 DEBUG : sub/deep/index.html: md5 = 0f8da58fcb097a8f94a83e35f5436f3d OK
2026/11/11 03:37:00 DEBUG : sub/deep/index.html: size = 12128 OK
2026/11/11 03:37:00 INFO  : sub/deep/index.html: Copied (new)
--- PASS: TestIndexLinkIndex (14.68s)
=== RUN   TestIndexDirTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:37:08 DEBUG : file1.txt: md5 = 71038122a63dfe1a7f9d952a1e7f7844 OK
2026/11/11 03:37:11 DEBUG : sub/file2.txt: md5 = e0d3d2724ee3e808aeba3a8e2b972f24 OK
2026/11/11 03:37:13 DEBUG : sub/deep/file3.txt: md5 = 8878cdcb0731a4ba13ade831ede01d0d OK
2026/11/11 03:37:15 DEBUG : sub/index.json: md5 = e3cfca11d4b383f58e41d566ef81a3a0 OK
2026/11/11 03:37:15 DEBUG : sub/index.json: size = 259 OK
2026/11/11 03:37:15 INFO  : sub/index.json: Copied (new)
2026/11/11 03:37:15 DEBUG : sub/deep/index.json: md5 = d192b2469fdb91a05446fcbc6afa8a39 OK
2026/11/11 03:37:15 DEBUG : sub/deep/index.json: size = 139 OK
2026/11/11 03:37:15 INFO  : sub/deep/index.json: Copied (new)
2026/11/11 03:37:15 DEBUG : index.json: md5 = 87194d486f8de79ab35c560d20d3327e OK
2026/11/11 03:37:15 DEBUG : index.json: size = 257 OK
2026/11/11 03:37:15 INFO  : index.json: Copied (new)
2026/11/11 03:37:17 DEBUG : sub/deep/index.json: Unchanged skipping
2026/11/11 03:37:18 DEBUG : sub/index.json: md5 = 82d1076dec5e272cc860c098b185b095 OK
2026/11/11 03:37:18 DEBUG : sub/index.json: size = 239 OK
2026/11/11 03:37:18 INFO  : sub/index.json: Copied (replaced existing)
2026/11/11 03:37:18 DEBUG : index.json: md5 = c347ff93a316617e4769d3a77827fe62 OK
2026/11/11 03:37:18 DEBUG : index.json: size = 237 OK
2026/11/11 03:37:18 INFO  : index.json: Copied (replaced existing)
2026/11/11 03:37:20 DEBUG : sub/deep/index.json: md5 = 17fbc9a6a8c725330431b1284226cd92 OK
2026/11/11 03:37:20 DEBUG : sub/deep/index.json: size = 119 OK
2026/11/11 03:37:20 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/11/11 03:37:20 DEBUG : sub/index.json: md5 = d0750b2271a0c466261d17ce99d4941a OK
2026/11/11 03:37:20 DEBUG : sub/index.json: size = 215 OK
2026/11/11 03:37:20 INFO  : sub/index.json: Copied (replaced existing)
2026/11/11 03:37:21 DEBUG : index.json: md5 = 6b87124ff4f72586ff00fdb83c642e3b OK
2026/11/11 03:37:21 DEBUG : index.json: size = 213 OK
2026/11/11 03:37:21 INFO  : index.json: Copied (replaced existing)
--- PASS: TestIndexDirTime (19.95s)
=== RUN   TestIndexTemplate
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:37:28 DEBUG : file1.txt: md5 = 161bdebdd930316ff6ae15e0252560d9 OK
2026/11/11 03:37:30 DEBUG : sub/file2.txt: md5 = af209a82ae869501a90fc16e0ec62ba1 OK
2026/11/11 03:37:32 DEBUG : sub/deep/file3.txt: md5 = 0d6ff602203438b98103e9dff9148568 OK
2026/11/11 03:37:35 DEBUG : sub/deep/list.txt: md5 = 6fb4a8d820fb525f93f274b0b22f7f41 OK
2026/11/11 03:37:35 DEBUG : sub/deep/list.txt: size = 47 OK
2026/11/11 03:37:35 INFO  : sub/deep/list.txt: Copied (new)
2026/11/11 03:37:35 DEBUG : list.txt: md5 = 2f3c81db46b64d7fdad1249227cd7136 OK
2026/11/11 03:37:35 DEBUG : list.txt: size = 59 OK
2026/11/11 03:37:35 INFO  : list.txt: Copied (new)
2026/11/11 03:37:35 DEBUG : sub/list.txt: md5 = 54b0e49b0f407e5e745c0472f253663d OK
2026/11/11 03:37:35 DEBUG : sub/list.txt: size = 64 OK
2026/11/11 03:37:35 INFO  : sub/list.txt: Copied (new)
--- PASS: TestIndexTemplate (13.94s)
=== 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:37:42 DEBUG : file1.txt: md5 = f3d6cee14fc63f830425c04f11cd79f3 OK
2026/11/11 03:37:44 DEBUG : sub/file2.txt: md5 = 7c1e1116f2d1f7657f3384a9a944028a OK
2026/11/11 03:37:46 DEBUG : sub/deep/file3.txt: md5 = 52d0e5f51b63072326f8b79b53276a81 OK
2026/11/11 03:37:48 DEBUG : other/notes.md: md5 = 4f674ffee54c3c5a7f75ab107beda653 OK
2026/11/11 03:37:51 DEBUG : sub/index.html: md5 = 79c83377f3fabdb25a7e2e81f3bf6f32 OK
2026/11/11 03:37:51 DEBUG : sub/index.html: size = 12306 OK
2026/11/11 03:37:51 INFO  : sub/index.html: Copied (new)
2026/11/11 03:37:51 DEBUG : other/index.html: md5 = f8431a78222a742bcd70f58cf64d9d19 OK
2026/11/11 03:37:51 DEBUG : other/index.html: size = 12058 OK
2026/11/11 03:37:51 INFO  : other/index.html: Copied (new)
2026/11/11 03:37:51 DEBUG : sub/deep/index.html: md5 = eb043728187c1be94544fba612f3ac72 OK
2026/11/11 03:37:51 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/11 03:37:51 INFO  : sub/deep/index.html: Copied (new)
2026/11/11 03:37:51 DEBUG : index.html: md5 = c6f221f14d3271061559eceb01000a0f OK
2026/11/11 03:37:51 DEBUG : index.html: size = 12399 OK
2026/11/11 03:37:51 INFO  : index.html: Copied (new)
2026/11/11 03:37:52 DEBUG : sub/deep/file4.txt: md5 = ac24e5cc8b0306e2809dd8ea9d98a488 OK
2026/11/11 03:37:53 DEBUG : other/undeclared.txt: md5 = 1b79532ba41a351fb9c59e10513631b9 OK
2026/11/11 03:37:53 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 3 directories and walking 0 changed directories
2026/11/11 03:37:55 DEBUG : sub/index.html: Unchanged skipping
2026/11/11 03:37:55 DEBUG : index.html: Unchanged skipping
2026/11/11 03:37:55 DEBUG : sub/deep/index.html: md5 = dae0c26e32759bc3b3b004b13f5a808a OK
2026/11/11 03:37:55 DEBUG : sub/deep/index.html: size = 12346 OK
2026/11/11 03:37:55 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/11/11 03:37:59 DEBUG : sub/new/file5.txt: md5 = 16958001b90f991c6de5d6bcb5ec4386 OK
2026/11/11 03:37:59 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 3 directories and walking 0 changed directories
2026/11/11 03:38:00 DEBUG : index.html: Unchanged skipping
2026/11/11 03:38:01 DEBUG : sub/index.html: md5 = 9ae606c4d141c8b9ee0b4bc547404dc2 OK
2026/11/11 03:38:01 DEBUG : sub/index.html: size = 12554 OK
2026/11/11 03:38:01 INFO  : sub/index.html: Copied (replaced existing)
2026/11/11 03:38:01 DEBUG : sub/new/index.html: md5 = 74fd7132edfe87c7e9122c668cf11166 OK
2026/11/11 03:38:01 DEBUG : sub/new/index.html: size = 12085 OK
2026/11/11 03:38:01 INFO  : sub/new/index.html: Copied (new)
2026/11/11 03:38:04 DEBUG : other/undeclared0.txt: md5 = e008091a5159d74a2e059065e5696124 OK
2026/11/11 03:38:04 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 1 directories and walking 1 changed directories
2026/11/11 03:38:05 DEBUG : index.html: Unchanged skipping
2026/11/11 03:38:06 DEBUG : other/index.html: md5 = ee733c46e339dab187c1c0c681ae5bd4 OK
2026/11/11 03:38:06 DEBUG : other/index.html: size = 12597 OK
2026/11/11 03:38:06 INFO  : other/index.html: Copied (replaced existing)
2026/11/11 03:38:08 DEBUG : other/undeclared1.txt: md5 = 97656d6cb1240d254ff6176e022613c5 OK
2026/11/11 03:38:08 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 1 directories and walking 0 changed directories
2026/11/11 03:38:10 DEBUG : index.html: Unchanged skipping
2026/11/11 03:38:10 DEBUG : other/index.html: md5 = fd7a2ffdc9cecd729019ae120828b786 OK
2026/11/11 03:38:10 DEBUG : other/index.html: size = 12867 OK
2026/11/11 03:38:10 INFO  : other/index.html: Copied (replaced existing)
2026/11/11 03:38:12 DEBUG : sub/file6.txt: md5 = 4e5857fdc52419ec3e640942bb5b3bb3 OK
2026/11/11 03:38:12 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Nothing changed so nothing to index
2026/11/11 03:38:13 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Root changed so doing a full index
2026/11/11 03:38:15 DEBUG : index.html: Unchanged skipping
2026/11/11 03:38:15 DEBUG : sub/new/index.html: Unchanged skipping
2026/11/11 03:38:15 DEBUG : other/index.html: Unchanged skipping
2026/11/11 03:38:15 DEBUG : sub/deep/index.html: Unchanged skipping
2026/11/11 03:38:15 DEBUG : sub/index.html: md5 = 89dec0bf41fde386e1e6be72810dfd2b OK
2026/11/11 03:38:15 DEBUG : sub/index.html: size = 12813 OK
2026/11/11 03:38:15 INFO  : sub/index.html: Copied (replaced existing)
2026/11/11 03:38:17 DEBUG : sub/file7.txt: md5 = 2b3baf2ac5202968d8aef34ce2429f95 OK
2026/11/11 03:38:17 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index would list 2 directories, more than 1, so doing a full index
2026/11/11 03:38:19 DEBUG : index.html: Unchanged skipping
2026/11/11 03:38:19 DEBUG : sub/new/index.html: Unchanged skipping
2026/11/11 03:38:19 DEBUG : other/index.html: Unchanged skipping
2026/11/11 03:38:19 DEBUG : sub/deep/index.html: Unchanged skipping
2026/11/11 03:38:19 DEBUG : sub/index.html: md5 = b4e9779e957b163f75552f404c90fe09 OK
2026/11/11 03:38:19 DEBUG : sub/index.html: size = 13071 OK
2026/11/11 03:38:19 INFO  : sub/index.html: Copied (replaced existing)
2026/11/11 03:38:22 DEBUG : sub/deep/file8.txt: md5 = 73a5be90ae1ca0760e43522171fee85d OK
2026/11/11 03:38:22 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 1 directories and walking 1 changed directories
2026/11/11 03:38:23 DEBUG : index.html: Unchanged skipping
2026/11/11 03:38:23 DEBUG : sub/new/index.html: Unchanged skipping
2026/11/11 03:38:23 DEBUG : sub/index.html: Unchanged skipping
2026/11/11 03:38:24 DEBUG : sub/deep/index.html: md5 = 683898b634c22e8fe18925a5f9aef81d OK
2026/11/11 03:38:24 DEBUG : sub/deep/index.html: size = 12604 OK
2026/11/11 03:38:24 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/11/11 03:38:26 DEBUG : sub/deep/file9.txt: md5 = dbb32214761412f36e581a8cf88bafdf OK
2026/11/11 03:38:27 DEBUG : sub/file10.txt: md5 = 208d38fe9c496313069a4e1331ff2894 OK
2026/11/11 03:38:27 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 2 directories and walking 0 changed directories
2026/11/11 03:38:28 DEBUG : index.html: Unchanged skipping
2026/11/11 03:38:29 DEBUG : sub/index.html: md5 = addf6f6ab3fac6bc9a747146810dd1e7 OK
2026/11/11 03:38:29 DEBUG : sub/index.html: size = 13331 OK
2026/11/11 03:38:29 INFO  : sub/index.html: Copied (replaced existing)
--- PASS: TestIndexChanged (61.88s)
=== RUN   TestIndexChangedDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:38:44 DEBUG : file1.txt: md5 = 9bc2d9fd660f7a555686602a66e95a7f OK
2026/11/11 03:38:46 DEBUG : sub/file2.txt: md5 = 78b10ee82c81eba6d9abc8671b4275fe OK
2026/11/11 03:38:48 DEBUG : sub/deep/file3.txt: md5 = a6644176258bac8f377da5303aed221b OK
2026/11/11 03:38:50 DEBUG : sub/index.html: md5 = ba70d2f636d47577cbfba22e4ce2cbca OK
2026/11/11 03:38:50 DEBUG : sub/index.html: size = 12306 OK
2026/11/11 03:38:50 INFO  : sub/index.html: Copied (new)
2026/11/11 03:38:50 DEBUG : index.html: md5 = e2cdd40904dce82cb4cceddb70b2bd85 OK
2026/11/11 03:38:50 DEBUG : index.html: size = 12147 OK
2026/11/11 03:38:50 INFO  : index.html: Copied (new)
2026/11/11 03:38:50 DEBUG : sub/deep/index.html: md5 = 306339846e34c0bad6b21b4b122ecddf OK
2026/11/11 03:38:50 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/11 03:38:50 INFO  : sub/deep/index.html: Copied (new)
2026/11/11 03:38:51 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 3 directories and walking 0 changed directories
2026/11/11 03:38:52 DEBUG : index.html: Unchanged skipping
2026/11/11 03:38:53 DEBUG : sub/index.html: Unchanged skipping
2026/11/11 03:38:53 DEBUG : sub/deep/index.html: md5 = 810f24bc631bb0de6a8af8c989b9a31c OK
2026/11/11 03:38:53 DEBUG : sub/deep/index.html: size = 11829 OK
2026/11/11 03:38:53 INFO  : sub/deep/index.html: Copied (replaced existing)
--- PASS: TestIndexChangedDelete (15.59s)
=== RUN   TestIndexChangedFiles
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:38:59 DEBUG : file1.txt: md5 = 4b33ae6654a100c0cc6be82ff93442bf OK
2026/11/11 03:39:02 DEBUG : sub/file2.txt: md5 = 6b7cbf398e65ec1d787e980f1b1e8569 OK
2026/11/11 03:39:04 DEBUG : sub/deep/file3.txt: md5 = cb6e0639c4b7d1676c0faf14b2202bed OK
2026/11/11 03:39:06 DEBUG : - odd/file.txt: md5 = 0efc7a4abb82b81078402e0f484f3dd4 OK
2026/11/11 03:39:08 DEBUG : index.html: md5 = 29946d56ebeb3c3a912db7d4befaee14 OK
2026/11/11 03:39:08 DEBUG : index.html: size = 12401 OK
2026/11/11 03:39:08 INFO  : index.html: Copied (new)
2026/11/11 03:39:08 DEBUG : sub/deep/index.html: md5 = 5b98e1759b9e0fe97624c2c120136844 OK
2026/11/11 03:39:08 DEBUG : sub/deep/index.html: size = 12087 OK
2026/11/11 03:39:08 INFO  : sub/deep/index.html: Copied (new)
2026/11/11 03:39:08 DEBUG : sub/index.html: md5 = 59d5497058da1378e3cab2f3d88f05b9 OK
2026/11/11 03:39:08 DEBUG : sub/index.html: size = 12306 OK
2026/11/11 03:39:08 INFO  : sub/index.html: Copied (new)
2026/11/11 03:39:08 DEBUG : - odd/index.html: md5 = 34a7127b22418f2fdf686f123782ca4a OK
2026/11/11 03:39:08 DEBUG : - odd/index.html: size = 12058 OK
2026/11/11 03:39:08 INFO  : - odd/index.html: Copied (new)
2026/11/11 03:39:10 DEBUG : - odd/file8.txt: md5 = 69c7bbca07960b73be301cd4423fcd8c OK
2026/11/11 03:39:11 DEBUG : sub/file9.txt: md5 = 64d32264e9924e55639916186fc4ca02 OK
2026/11/11 03:39:11 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 2 directories and walking 0 changed directories
2026/11/11 03:39:12 DEBUG : index.html: Unchanged skipping
2026/11/11 03:39:13 DEBUG : - odd/index.html: md5 = d129925898acabd8b106f6da8e640130 OK
2026/11/11 03:39:13 DEBUG : - odd/index.html: size = 12316 OK
2026/11/11 03:39:13 INFO  : - odd/index.html: Copied (replaced existing)
2026/11/11 03:39:14 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 4 directories and walking 0 changed directories
2026/11/11 03:39:16 DEBUG : index.html: Unchanged skipping
2026/11/11 03:39:16 DEBUG : - odd/index.html: Unchanged skipping
2026/11/11 03:39:16 DEBUG : sub/deep/index.html: Unchanged skipping
2026/11/11 03:39:17 DEBUG : sub/index.html: md5 = dae22cebf130a136f1103967f516de32 OK
2026/11/11 03:39:17 DEBUG : sub/index.html: size = 12565 OK
2026/11/11 03:39:17 INFO  : sub/index.html: Copied (replaced existing)
--- PASS: TestIndexChangedFiles (26.75s)
=== RUN   TestIndexChangedDirTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:39:26 DEBUG : file1.txt: md5 = e8a4bdb78001b74ff5a33692ab1a4b57 OK
2026/11/11 03:39:28 DEBUG : sub/file2.txt: md5 = 882e903d25362cf10fbce0fedd4c365f OK
2026/11/11 03:39:30 DEBUG : sub/deep/file3.txt: md5 = efd38dc8c880ad707c76b5e2d2d52364 OK
2026/11/11 03:39:32 DEBUG : other/notes.md: md5 = 8da052f32c996ec4649ab81a830aeb02 OK
2026/11/11 03:39:34 DEBUG : sub/index.json: md5 = 48163c38191bbc9854e99647aa2c5c74 OK
2026/11/11 03:39:34 DEBUG : sub/index.json: size = 259 OK
2026/11/11 03:39:34 INFO  : sub/index.json: Copied (new)
2026/11/11 03:39:35 DEBUG : index.json: md5 = 33c62772f2009c1387e02b7be909e298 OK
2026/11/11 03:39:35 DEBUG : index.json: size = 379 OK
2026/11/11 03:39:35 INFO  : index.json: Copied (new)
2026/11/11 03:39:35 DEBUG : other/index.json: md5 = 95ac0bcf9178940579ff1985d87aa648 OK
2026/11/11 03:39:35 DEBUG : other/index.json: size = 144 OK
2026/11/11 03:39:35 INFO  : other/index.json: Copied (new)
2026/11/11 03:39:35 DEBUG : sub/deep/index.json: md5 = 5666a9a96f868639f7e8964fd905e769 OK
2026/11/11 03:39:35 DEBUG : sub/deep/index.json: size = 139 OK
2026/11/11 03:39:35 INFO  : sub/deep/index.json: Copied (new)
2026/11/11 03:39:36 DEBUG : sub/deep/file4.txt: md5 = 16d42d4bca1c94fd2e5dd4a7ebdfb1e4 OK
2026/11/11 03:39:36 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Partial index: listing 3 directories and walking 0 changed directories
2026/11/11 03:39:38 DEBUG : sub/deep/index.json: md5 = c65be4abfc9ff0d1716cea64302fac62 OK
2026/11/11 03:39:38 DEBUG : sub/deep/index.json: size = 275 OK
2026/11/11 03:39:38 INFO  : sub/deep/index.json: Copied (replaced existing)
2026/11/11 03:39:39 DEBUG : sub/index.json: md5 = dc1c16a29a0accbd74e5485e70746f9c OK
2026/11/11 03:39:39 DEBUG : sub/index.json: size = 259 OK
2026/11/11 03:39:39 INFO  : sub/index.json: Copied (replaced existing)
2026/11/11 03:39:39 DEBUG : index.json: md5 = e34a3b74611389c553f75ece760278c3 OK
2026/11/11 03:39:39 DEBUG : index.json: size = 379 OK
2026/11/11 03:39:39 INFO  : index.json: Copied (replaced existing)
--- PASS: TestIndexChangedDirTime (21.57s)
=== RUN   TestListDirSorted
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:39:48 DEBUG : a.txt: md5 = 8a8b07193f484af340396c69179c5724 OK
2026/11/11 03:39:49 DEBUG : zend.txt: md5 = ff5f58c203415fe221c49b8a9ab17240 OK
2026/11/11 03:39:51 DEBUG : sub dir/hello world: md5 = d15f29d560a834e7e9344aaf0b87c85c OK
2026/11/11 03:39:53 DEBUG : sub dir/hello world2: md5 = 22965fb659ddff11710f3a632fc8c3cd OK
2026/11/11 03:39:55 DEBUG : sub dir/ignore dir/.ignore: md5 = c81af9cc81386d2ad1a9ab4dc1933dec OK
2026/11/11 03:39:56 DEBUG : sub dir/ignore dir/should be ignored: md5 = fd03e3a36c1d515024bd911f3a6661d4 OK
2026/11/11 03:39:59 DEBUG : sub dir/sub sub dir/hello world3: md5 = 81ecfd162a738f79202f341d82264c93 OK
2026/11/11 03:40:00 DEBUG : a.txt: Excluded (Size Filter)
2026/11/11 03:40:00 DEBUG : a.txt: Excluded
2026/11/11 03:40:00 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/11/11 03:40:00 DEBUG : sub dir/hello world2: Excluded
2026/11/11 03:40:00 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/11/11 03:40:00 DEBUG : sub dir/hello world: Excluded
2026/11/11 03:40:01 DEBUG : sub dir/ignore dir: Excluded
2026/11/11 03:40:01 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/11/11 03:40:01 DEBUG : sub dir/hello world2: Excluded
2026/11/11 03:40:01 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/11/11 03:40:01 DEBUG : sub dir/hello world: Excluded
2026/11/11 03:40:01 DEBUG : sub dir/ignore dir: Excluded
--- PASS: TestListDirSorted (21.50s)
=== RUN   TestListDirSortedFn
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:40:09 DEBUG : a.txt: md5 = 931320c7c3f0bd9d03225e0af3444198 OK
2026/11/11 03:40:11 DEBUG : zend.txt: md5 = 224a51e61d83b3be5d3dd97da848c560 OK
2026/11/11 03:40:13 DEBUG : sub dir/hello world: md5 = a089c34553dbd641fec3d340d45246f3 OK
2026/11/11 03:40:14 DEBUG : sub dir/hello world2: md5 = 7ee80041f8e6285db4e2d015537680a7 OK
2026/11/11 03:40:16 DEBUG : sub dir/ignore dir/.ignore: md5 = 6b4ea97c3f6bd926db5fa2ed539a38ff OK
2026/11/11 03:40:18 DEBUG : sub dir/ignore dir/should be ignored: md5 = 0494b07066324a179fbbe0dc522f4260 OK
2026/11/11 03:40:20 DEBUG : sub dir/sub sub dir/hello world3: md5 = 36648b636564a7ac3f34b8c023ec71ce OK
2026/11/11 03:40:21 DEBUG : a.txt: Excluded (Size Filter)
2026/11/11 03:40:21 DEBUG : a.txt: Excluded
2026/11/11 03:40:22 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/11/11 03:40:22 DEBUG : sub dir/hello world: Excluded
2026/11/11 03:40:22 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/11/11 03:40:22 DEBUG : sub dir/hello world2: Excluded
2026/11/11 03:40:23 DEBUG : sub dir/ignore dir: Excluded
2026/11/11 03:40:23 DEBUG : sub dir/hello world: Excluded (Size Filter)
2026/11/11 03:40:23 DEBUG : sub dir/hello world: Excluded
2026/11/11 03:40:23 DEBUG : sub dir/hello world2: Excluded (Size Filter)
2026/11/11 03:40:23 DEBUG : sub dir/hello world2: Excluded
2026/11/11 03:40:23 DEBUG : sub dir/ignore dir: Excluded
--- PASS: TestListDirSortedFn (21.28s)
=== RUN   TestListJSON
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:40:31 DEBUG : file1: md5 = a0f31074f554e357b2f3e004b3d61b9d OK
2026/11/11 03:40:33 DEBUG : sub/file2: md5 = 3e031ab60de5a0196bc9f80acf368d8f 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/11 03:40:36 ERROR : file1: Failed to read hash: hash type not supported
=== RUN   TestListJSON/Metadata
2026/11/11 03:40:36 DEBUG : eer8kka55qnghc34cq76ca668g: Fetching metadata
2026/11/11 03:40:36 DEBUG : 150fuo3cn4j1uenq6r4g4qk6t4: Fetching metadata
--- PASS: TestListJSON (9.63s)
    --- PASS: TestListJSON/Default (0.24s)
    --- PASS: TestListJSON/FilesOnly (0.27s)
    --- PASS: TestListJSON/DirsOnly (0.24s)
    --- PASS: TestListJSON/Recurse (0.55s)
    --- PASS: TestListJSON/SubDir (0.23s)
    --- PASS: TestListJSON/NoModTime (0.24s)
    --- PASS: TestListJSON/NoMimeType (0.26s)
    --- PASS: TestListJSON/ShowHash (0.25s)
    --- PASS: TestListJSON/HashTypes (0.37s)
    --- PASS: TestListJSON/Metadata (0.63s)
=== RUN   TestStatJSON
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:40:40 DEBUG : file1: md5 = 0e580c6bb9c65e2d2e275b6e61105e4b OK
2026/11/11 03:40:42 DEBUG : sub/file2: md5 = 0d7d7aeb2c2a7465bdacc3fcb68aa82f 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/11 03:40:46 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/notfound"
2026/11/11 03:40:46 DEBUG : Config file has changed externally - reloading
2026/11/11 03:40:46 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/qe0i31qdkoejk60elps0ni5sqk"
--- PASS: TestStatJSON (11.16s)
    --- PASS: TestStatJSON/Root (0.19s)
    --- PASS: TestStatJSON/RootFilesOnly (0.00s)
    --- PASS: TestStatJSON/RootDirsOnly (0.23s)
    --- PASS: TestStatJSON/Dir (0.57s)
    --- PASS: TestStatJSON/DirWithTrailingSlash (0.21s)
    --- PASS: TestStatJSON/File (0.20s)
    --- PASS: TestStatJSON/NotFound (0.43s)
    --- PASS: TestStatJSON/DirFilesOnly (0.25s)
    --- PASS: TestStatJSON/FileFilesOnly (0.21s)
    --- PASS: TestStatJSON/NotFoundFilesOnly (0.20s)
    --- PASS: TestStatJSON/DirDirsOnly (0.25s)
    --- PASS: TestStatJSON/FileDirsOnly (0.24s)
    --- PASS: TestStatJSON/NotFoundDirsOnly (0.23s)
    --- PASS: TestStatJSON/RootNotFound (1.63s)
=== RUN   TestStatJSONMemory
2026/11/11 03:40:50 DEBUG : Creating backend with remote ":memory:"
2026/11/11 03:40:50 DEBUG : Memory root '': File to upload is small (5 bytes), uploading instead of streaming
2026/11/11 03:40:50 DEBUG : sub/file1: size = 5 OK
2026/11/11 03:40:50 DEBUG : sub/file1: md5 = 5d41402abc4b2a76b9719d911017c592 OK
2026/11/11 03:40:50 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:40:50 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Making directory
2026/11/11 03:40:50 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Making directory
--- PASS: TestMkdir (0.66s)
=== RUN   TestLsd
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:40:53 DEBUG : sub dir/hello world: md5 = 75ec59358e0b7dc2b4977fa4c3ae67dc OK
--- PASS: TestLsd (4.38s)
=== RUN   TestLs
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:40:56 DEBUG : potato2: md5 = 684102a185364fdc361af032f14fc041 OK
2026/11/11 03:40:58 DEBUG : empty space: md5 = 85fba2d04ef4899df23d1d1be88951d8 OK
--- PASS: TestLs (4.60s)
=== RUN   TestLsWithFilesFrom
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:41:01 DEBUG : potato2: md5 = 6a918ada7ccb16535b799cabb6fd2a20 OK
2026/11/11 03:41:03 DEBUG : empty space: md5 = 13e3bed279c1b81572ece6968b27dc4c OK
2026/11/11 03:41:03 DEBUG : empty space: Excluded (FilesFrom Filter)
--- PASS: TestLsWithFilesFrom (4.77s)
=== RUN   TestLsLong
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:41:06 DEBUG : potato2: md5 = 221ee01c498f65ac7aac923c61436231 OK
2026/11/11 03:41:07 DEBUG : empty space: md5 = e85011d2f0ba7efcae3723e15767e110 OK
--- PASS: TestLsLong (4.70s)
=== RUN   TestHashSums
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:41:11 DEBUG : potato2: md5 = 2bb7a41b85c5a3b3a5c9e1411fc9a40e OK
2026/11/11 03:41:12 DEBUG : empty space: md5 = 6fb7f92e1d513ec151760d0c566728d3 OK
--- PASS: TestHashSums (4.51s)
=== RUN   TestHashSumsWithErrors
2026/11/11 03:41:14 DEBUG : Creating backend with remote ":memory:"
2026/11/11 03:41:14 ERROR : file1: hash unsupported: hash type not supported
2026/11/11 03:41:14 ERROR : sub/file1: hash unsupported: hash type not supported
2026/11/11 03:41:14 ERROR : sub/file1: hash unsupported: hash type not supported
--- PASS: TestHashSumsWithErrors (0.00s)
=== RUN   TestHashStream
2026/11/11 03:41:14 DEBUG : Creating md5 hash of 0 bytes read from input stream
2026/11/11 03:41:14 DEBUG : Creating md5 hash of 0 bytes read from input stream
2026/11/11 03:41:14 DEBUG : Creating sha1 hash of 0 bytes read from input stream
2026/11/11 03:41:14 DEBUG : Creating sha1 hash of 0 bytes read from input stream
2026/11/11 03:41:14 DEBUG : Creating md5 hash of 12 bytes read from input stream
2026/11/11 03:41:14 DEBUG : Creating md5 hash of 12 bytes read from input stream
2026/11/11 03:41:14 DEBUG : Creating sha1 hash of 12 bytes read from input stream
2026/11/11 03:41:14 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:41:15 DEBUG : potato2: md5 = cf0c237bbf074d62a7fabd4e81e6fa79 OK
2026/11/11 03:41:16 DEBUG : empty space: md5 = 5ce4ef4f0afa1b6da8b33c2d2a09ad9f OK
2026/11/11 03:41:18 DEBUG : sub dir/potato3: md5 = d9d363c2e0e3dbd738c3a28bcf2d8f8f OK
--- PASS: TestCount (8.14s)
=== RUN   TestDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:41:23 DEBUG : small: md5 = 191dc76752a0c1c82c434be5f542422d OK
2026/11/11 03:41:25 DEBUG : medium: md5 = b82f32a026287269c0b44b2a1dc8b8ba OK
2026/11/11 03:41:26 DEBUG : large: md5 = 4b44f9d3491d2c23fb22338644b15a1c OK
2026/11/11 03:41:26 DEBUG : Waiting for deletions to finish
2026/11/11 03:41:27 DEBUG : large: Excluded (Size Filter)
2026/11/11 03:41:27 INFO  : medium: Deleted
2026/11/11 03:41:27 INFO  : small: Deleted
--- PASS: TestDelete (6.24s)
=== RUN   TestDeleteFatalError
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:41:29 DEBUG : file0: md5 = 3a6640174884f692be758c44341aec7b OK
2026/11/11 03:41:31 DEBUG : file1: md5 = 0cd42fe39217fb5b34bb6477d17be322 OK
2026/11/11 03:41:32 DEBUG : file2: md5 = 992caa88353d763c63150fc46cdda7b7 OK
2026/11/11 03:41:33 DEBUG : file3: md5 = d875127cad6851b2a0071bfe0eddfc11 OK
2026/11/11 03:41:35 DEBUG : file4: md5 = 02c51b53afcb756dc05717ba57a9252a OK
2026/11/11 03:41:36 DEBUG : file5: md5 = 24d7b5a2c0729a3a1b4e2227655af33b OK
2026/11/11 03:41:37 DEBUG : file6: md5 = 2fb160c355de26f7baf692ab1371377c OK
2026/11/11 03:41:39 DEBUG : file7: md5 = 65db3db70547bf64dd72e35b17e75a16 OK
2026/11/11 03:41:40 DEBUG : file8: md5 = 75dc10b94cb324d5cc0d667c132ecc37 OK
2026/11/11 03:41:42 DEBUG : file9: md5 = f8321f8484732621c4bc4ccaa54414ef OK
2026/11/11 03:41:43 DEBUG : file10: md5 = b3e0a6d4564be2fe1819206e61ebc905 OK
2026/11/11 03:41:44 DEBUG : file11: md5 = 3d8044c0840e4a058583494ae6e7561b OK
2026/11/11 03:41:46 DEBUG : file12: md5 = dad645982290c925fee1d877e7aa00db OK
2026/11/11 03:41:47 DEBUG : file13: md5 = 65c5129bc831f5b32f0f2e6aad88b3a5 OK
2026/11/11 03:41:48 DEBUG : file14: md5 = bd66276a3f5f4776f51ce89cbc82a2fc OK
2026/11/11 03:41:50 DEBUG : file15: md5 = cfea05c3f521db0b32fbe1ed3457bb02 OK
2026/11/11 03:41:51 DEBUG : file16: md5 = 73bda85be4008b54706b892ec2f339b7 OK
2026/11/11 03:41:52 DEBUG : file17: md5 = 867292ec21af00266e7e9a92edddfec0 OK
2026/11/11 03:41:54 DEBUG : file18: md5 = f3d96b7edeb39923f14db38ed6a112b6 OK
2026/11/11 03:41:55 DEBUG : file19: md5 = 76d1615035dac04da27e958a8e1b1092 OK
2026/11/11 03:41:55 DEBUG : Waiting for deletions to finish
2026/11/11 03:41:55 ERROR : file6: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file5: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file19: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file13: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file18: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file3: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file17: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file0: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file15: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file1: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file10: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file4: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file8: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file7: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file14: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file9: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file2: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file11: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file12: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:41:55 ERROR : file16: Got fatal error on delete: --max-delete threshold reached
--- PASS: TestDeleteFatalError (37.10s)
=== RUN   TestMaxDelete
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:42:07 DEBUG : small: md5 = 4da578919504afafa251949181eaf39a OK
2026/11/11 03:42:08 DEBUG : medium: md5 = 677689b5a1781fac9aa85dea5c8f35b3 OK
2026/11/11 03:42:09 DEBUG : large: md5 = 9f64bfe586b4a28a2d6f83fbee63ddde OK
2026/11/11 03:42:10 DEBUG : Waiting for deletions to finish
2026/11/11 03:42:10 ERROR : large: Got fatal error on delete: --max-delete threshold reached
2026/11/11 03:42:10 INFO  : small: Deleted
2026/11/11 03:42:10 INFO  : medium: Deleted
--- PASS: TestMaxDelete (6.84s)
=== RUN   TestMaxDeleteSizeLargeFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:42:13 DEBUG : small: md5 = cc2569b595a17b855953c72ce19df83d OK
2026/11/11 03:42:15 DEBUG : medium: md5 = d3e95a2173970fa0ca0897f700b5e518 OK
2026/11/11 03:42:16 DEBUG : large: md5 = 95abd1dbe1c52ec9d29ec9f5ecad6b39 OK
2026/11/11 03:42:16 DEBUG : Waiting for deletions to finish
2026/11/11 03:42:16 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached
2026/11/11 03:42:17 INFO  : small: Deleted
2026/11/11 03:42:17 INFO  : medium: Deleted
--- PASS: TestMaxDeleteSizeLargeFile (6.53s)
=== RUN   TestMaxDeleteSize
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:42:20 DEBUG : small: md5 = d03f1e70552e53a86d9dee64100cd1ce OK
2026/11/11 03:42:21 DEBUG : medium: md5 = 5b7ac16ba362130c1234fd14ae07aa5e OK
2026/11/11 03:42:23 DEBUG : large: md5 = ba06a964a58716749d41fd1d8dfe31a1 OK
2026/11/11 03:42:23 DEBUG : Waiting for deletions to finish
2026/11/11 03:42:23 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached
2026/11/11 03:42:23 INFO  : small: Deleted
2026/11/11 03:42:23 INFO  : medium: Deleted
--- PASS: TestMaxDeleteSize (6.37s)
=== RUN   TestReadFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:42:26 DEBUG : ReadFile: md5 = ea4a0c389749296296167233bf984bd3 OK
--- PASS: TestReadFile (3.87s)
=== RUN   TestRetry
2026/11/11 03:42:29 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 1/5
2026/11/11 03:42:29 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 2/5
2026/11/11 03:42:29 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
2026/11/11 03:42:29 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
2026/11/11 03:42:29 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG: trying again in 10ms
2026/11/11 03:42:29 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/11 03:42:29 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:42:30 DEBUG : file1: md5 = ef7f15f631875b7008f5cc646f5e04f2 OK
2026/11/11 03:42:31 DEBUG : file2: md5 = ffa661372f3af4dfec808bfce32d7855 OK
--- PASS: TestCat (16.70s)
=== RUN   TestPurge
2026/11/11 03:42:45 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-lekifun9bisi"
2026/11/11 03:42:45 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:42:46 DEBUG : Creating backend with remote "TestDrive:crypt/9c0k4rdpluo7bvdj9uagmv8s566a79b5j0qtp9bvu5k9mk8tg1e0"
2026/11/11 03:42:46 DEBUG : Creating backend with remote "/tmp/rclone1155905229"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-lekifun9bisi'", Local "Local file system at /tmp/rclone1155905229", Modify Window "1ms"
2026/11/11 03:42:51 DEBUG : A1/B1/C1/one: md5 = bd40185237b891ea71a6010d87dad75d OK
2026/11/11 03:42:51 INFO  : A2: Making directory
2026/11/11 03:42:51 INFO  : A1/B2: Making directory
2026/11/11 03:42:52 INFO  : A1/B2/C2: Making directory
2026/11/11 03:42:53 INFO  : A1/B1/C3: Making directory
2026/11/11 03:42:54 INFO  : A3: Making directory
2026/11/11 03:42:54 INFO  : A3/B3: Making directory
2026/11/11 03:42:55 INFO  : A3/B3/C4: Making directory
2026/11/11 03:42:57 DEBUG : A1/two: md5 = fe6f71dcaea86fe18ab0922b50ea4544 OK
2026/11/11 03:43:01 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-lekifun9bisi': Purge remote
2026/11/11 03:43:01 NOTICE: purge failed: directory not found
--- PASS: TestPurge (15.51s)
=== RUN   TestRmdirsNoLeaveRoot
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:43:05 DEBUG : A1/B1/C1/one: md5 = 68a37602e62192035372e3088dc2982f OK
2026/11/11 03:43:05 INFO  : A2: Making directory
2026/11/11 03:43:06 INFO  : A1/B2: Making directory
2026/11/11 03:43:06 INFO  : A1/B2/C2: Making directory
2026/11/11 03:43:07 INFO  : A1/B1/C3: Making directory
2026/11/11 03:43:08 INFO  : A3: Making directory
2026/11/11 03:43:08 INFO  : A3/B3: Making directory
2026/11/11 03:43:09 INFO  : A3/B3/C4: Making directory
2026/11/11 03:43:11 DEBUG : A1/two: md5 = eacd84c53cf875fc643c9e96dce970c4 OK
2026/11/11 03:43:12 DEBUG : removing 1 level 3 directories
2026/11/11 03:43:12 INFO  : A3/B3/C4: Removing directory
2026/11/11 03:43:15 DEBUG : removing 2 level 3 directories
2026/11/11 03:43:15 INFO  : A1/B2/C2: Removing directory
2026/11/11 03:43:15 INFO  : A1/B1/C3: Removing directory
2026/11/11 03:43:16 DEBUG : removing 2 level 2 directories
2026/11/11 03:43:16 INFO  : A3/B3: Removing directory
2026/11/11 03:43:16 INFO  : A1/B2: Removing directory
2026/11/11 03:43:16 DEBUG : removing 2 level 1 directories
2026/11/11 03:43:16 INFO  : A3: Removing directory
2026/11/11 03:43:16 INFO  : A2: Removing directory
2026/11/11 03:43:20 DEBUG : removing 1 level 3 directories
2026/11/11 03:43:20 INFO  : A1/B1/C1: Removing directory
2026/11/11 03:43:21 DEBUG : removing 1 level 2 directories
2026/11/11 03:43:21 INFO  : A1/B1: Removing directory
2026/11/11 03:43:22 DEBUG : removing 1 level 1 directories
2026/11/11 03:43:22 INFO  : A1: Removing directory
2026/11/11 03:43:22 DEBUG : removing 1 level 0 directories
2026/11/11 03:43:22 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Removing directory
--- PASS: TestRmdirsNoLeaveRoot (22.69s)
=== RUN   TestRmdirsLeaveRoot
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:43:24 INFO  : A1: Making directory
2026/11/11 03:43:25 INFO  : A1/B1: Making directory
2026/11/11 03:43:26 INFO  : A1/B1/C1: Making directory
2026/11/11 03:43:28 DEBUG : removing 1 level 3 directories
2026/11/11 03:43:28 INFO  : A1/B1/C1: Removing directory
2026/11/11 03:43:29 DEBUG : removing 1 level 2 directories
2026/11/11 03:43:29 INFO  : A1/B1: Removing directory
--- PASS: TestRmdirsLeaveRoot (7.52s)
=== RUN   TestRmdirsWithFilter
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:43:31 INFO  : A1: Making directory
2026/11/11 03:43:32 INFO  : A1/B1: Making directory
2026/11/11 03:43:33 INFO  : A1/B1/C1: Making directory
2026/11/11 03:43:35 DEBUG : removing 1 level 3 directories
2026/11/11 03:43:35 INFO  : A1/B1/C1: Removing directory
2026/11/11 03:43:36 DEBUG : removing 1 level 2 directories
2026/11/11 03:43:36 INFO  : A1/B1: Removing directory
--- PASS: TestRmdirsWithFilter (7.35s)
=== RUN   TestCopyURL
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:43:40 DEBUG : file1: md5 = ae0999a4f33388a69b2d34ff95d10ec4 OK
2026/11/11 03:43:40 DEBUG : file1: size = 14 OK
2026/11/11 03:43:41 DEBUG : filename.txt: File name found in url
2026/11/11 03:43:42 DEBUG : filename.txt: md5 = 0b04f0f43d4a197b0de986369f7d4afc OK
2026/11/11 03:43:42 DEBUG : filename.txt: size = 14 OK
2026/11/11 03:43:42 DEBUG : headerfilename.txt: filename found in Content-Disposition header.
2026/11/11 03:43:44 DEBUG : headerfilename.txt: md5 = d78fc0dbcbee872b6584efe8da4b1620 OK
2026/11/11 03:43:44 DEBUG : headerfilename.txt: size = 14 OK
2026/11/11 03:43:45 DEBUG : file2: md5 = 75670da24aaa4e8f21fb25c2fc254928 OK
2026/11/11 03:43:45 DEBUG : file2: size = 14 OK
--- PASS: TestCopyURL (8.86s)
=== RUN   TestCopyURLDownloadHeaders
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:43:49 DEBUG : file1: md5 = 3f316685d8ba3e13009af721b4fab28c OK
2026/11/11 03:43:49 DEBUG : file1: size = 14 OK
--- PASS: TestCopyURLDownloadHeaders (2.20s)
=== RUN   TestCopyURLToWriter
--- PASS: TestCopyURLToWriter (0.00s)
=== RUN   TestMoveFile
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:43:50 DEBUG : file1: Need to transfer - File not found at Destination
2026/11/11 03:43:52 DEBUG : sub/file2: md5 = 3391367c3c9176cf796b3ef5bc7c9153 OK
2026/11/11 03:43:52 DEBUG : sub/file2: size = 14 OK
2026/11/11 03:43:52 INFO  : file1: Copied (new) to: sub/file2
2026/11/11 03:43:52 INFO  : file1: Deleted
2026/11/11 03:43:53 DEBUG : sub/file2: size = 14 OK
2026/11/11 03:43:53 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/11 03:43:53 DEBUG : file1: Unchanged skipping
2026/11/11 03:43:53 INFO  : file1: Deleted
2026/11/11 03:43:53 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': don't need to copy/move sub/file2, it is already at target location
--- PASS: TestMoveFile (5.79s)
=== RUN   TestMoveFileWithIgnoreExisting
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:43:56 DEBUG : file1: Need to transfer - File not found at Destination
2026/11/11 03:43:57 DEBUG : file1: md5 = f2a7e2344584ff5746d59a041928ec99 OK
2026/11/11 03:43:57 DEBUG : file1: size = 14 OK
2026/11/11 03:43:57 INFO  : file1: Copied (new)
2026/11/11 03:43:57 INFO  : file1: Deleted
2026/11/11 03:43:58 DEBUG : file1: Destination exists, skipping
2026/11/11 03:43:58 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set
--- PASS: TestMoveFileWithIgnoreExisting (3.45s)
=== RUN   TestMoveFileImmutable
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:44:00 DEBUG : existing: md5 = ad636609e3512170b8ae8b01f0032bce OK
2026/11/11 03:44:01 DEBUG : existing: size = 8 (Local file system at /tmp/rclone875949583)
2026/11/11 03:44:01 DEBUG : existing: size = 6 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka')
2026/11/11 03:44:01 DEBUG : existing: Sizes differ
2026/11/11 03:44:01 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
--- PASS: TestCaseInsensitiveMoveFile (0.44s)
=== RUN   TestMoveOntoItself
=== RUN   TestMoveOntoItself/viaSubdir=false,disableMove=false
2026/11/11 03:44:02 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-hudulof8gase"
2026/11/11 03:44:02 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:44:02 DEBUG : Creating backend with remote "TestDrive:crypt/uq39b726nh2ntohd1mtt51ag4pnv49e7l33cc31hdgkonh331nf0"
2026/11/11 03:44:03 DEBUG : Creating backend with remote "/tmp/rclone4187438838"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-hudulof8gase'", Local "Local file system at /tmp/rclone4187438838", Modify Window "1ms"
2026/11/11 03:44:06 DEBUG : sub/file1: md5 = 20437c03f67401101290327e543481da OK
2026/11/11 03:44:07 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-hudulof8gase': Purge remote
=== RUN   TestMoveOntoItself/viaSubdir=false,disableMove=true
2026/11/11 03:44:07 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-wocetan1posu"
2026/11/11 03:44:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:44:07 DEBUG : Creating backend with remote "TestDrive:crypt/htc5ds5pdn6go6s5k0oj97hmcqcm7mkpe22htepidjh7vntvesag"
2026/11/11 03:44:08 DEBUG : Creating backend with remote "/tmp/rclone561130765"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-wocetan1posu'", Local "Local file system at /tmp/rclone561130765", Modify Window "1ms"
2026/11/11 03:44:11 DEBUG : sub/file1: md5 = db19ab71ddfc398b4e75d7f7af3e75b8 OK
2026/11/11 03:44:11 DEBUG : Reset feature "Move"
2026/11/11 03:44:11 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-wocetan1posu': Purge remote
=== RUN   TestMoveOntoItself/viaSubdir=true,disableMove=false
2026/11/11 03:44:12 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-xexoyix9qeqa"
2026/11/11 03:44:12 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:44:12 DEBUG : Creating backend with remote "TestDrive:crypt/8jirnm5r20qr5vdpk0goe0qqm4rj5v4p3g32kde7jdhqqak1dugg"
2026/11/11 03:44:13 DEBUG : Creating backend with remote "/tmp/rclone1456438819"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-xexoyix9qeqa'", Local "Local file system at /tmp/rclone1456438819", Modify Window "1ms"
2026/11/11 03:44:16 DEBUG : sub/file1: md5 = a356986107b8221bd5530084fc2dda6f OK
2026/11/11 03:44:16 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-xexoyix9qeqa/sub"
2026/11/11 03:44:16 DEBUG : Creating backend with remote "TestDrive:crypt/8jirnm5r20qr5vdpk0goe0qqm4rj5v4p3g32kde7jdhqqak1dugg/150fuo3cn4j1uenq6r4g4qk6t4"
2026/11/11 03:44:17 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-xexoyix9qeqa': Purge remote
=== RUN   TestMoveOntoItself/viaSubdir=true,disableMove=true
2026/11/11 03:44:18 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-buxiwer5segu"
2026/11/11 03:44:18 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:44:18 DEBUG : Creating backend with remote "TestDrive:crypt/f3q8tep4e607eeigte7eit7g08rtkbvdj08ql236bccekuf3dbdg"
2026/11/11 03:44:19 DEBUG : Creating backend with remote "/tmp/rclone32744574"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-buxiwer5segu'", Local "Local file system at /tmp/rclone32744574", Modify Window "1ms"
2026/11/11 03:44:21 DEBUG : sub/file1: md5 = 43db3191aa6fdd0c725aa3eb02602a24 OK
2026/11/11 03:44:22 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-buxiwer5segu/sub"
2026/11/11 03:44:22 DEBUG : Creating backend with remote "TestDrive:crypt/f3q8tep4e607eeigte7eit7g08rtkbvdj08ql236bccekuf3dbdg/150fuo3cn4j1uenq6r4g4qk6t4"
2026/11/11 03:44:22 DEBUG : Reset feature "Move"
2026/11/11 03:44:23 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-buxiwer5segu': Purge remote
--- PASS: TestMoveOntoItself (20.91s)
    --- PASS: TestMoveOntoItself/viaSubdir=false,disableMove=false (4.74s)
    --- PASS: TestMoveOntoItself/viaSubdir=false,disableMove=true (4.88s)
    --- PASS: TestMoveOntoItself/viaSubdir=true,disableMove=false (5.70s)
    --- PASS: TestMoveOntoItself/viaSubdir=true,disableMove=true (5.59s)
=== RUN   TestMoveUnicodeEquivalentWithoutServerSideMove
2026/11/11 03:44:23 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-wikajoz7befa"
2026/11/11 03:44:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:44:23 DEBUG : Creating backend with remote "TestDrive:crypt/r8iss6efv8800e6hmfla6gq2kpbnl3sk3oufuijfdpsk6bm8b2kg"
2026/11/11 03:44:24 DEBUG : Creating backend with remote "/tmp/rclone3160694693"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-wikajoz7befa'", Local "Local file system at /tmp/rclone3160694693", Modify Window "1ms"
2026/11/11 03:44:24 DEBUG : Reset feature "Move"
2026/11/11 03:44:27 DEBUG : sub/équivalent.txt: md5 = 90197a258d1955b8c3f86ab5e00d455e OK
2026/11/11 03:44:28 DEBUG : sub/équivalent.txt: moving to sub/équivalent.txt-rclone-move-waxuwev4
2026/11/11 03:44:29 DEBUG : sub/équivalent.txt-rclone-move-waxuwev4: size = 14 OK
2026/11/11 03:44:29 INFO  : sub/équivalent.txt: Copied (server-side copy) to: sub/équivalent.txt-rclone-move-waxuwev4
2026/11/11 03:44:29 INFO  : sub/équivalent.txt: Deleted
2026/11/11 03:44:29 DEBUG : sub/équivalent.txt: moving to sub/équivalent.txt
2026/11/11 03:44:30 DEBUG : sub/équivalent.txt: size = 14 OK
2026/11/11 03:44:30 INFO  : sub/équivalent.txt-rclone-move-waxuwev4: Copied (server-side copy) to: sub/équivalent.txt
2026/11/11 03:44:30 INFO  : sub/équivalent.txt-rclone-move-waxuwev4: Deleted
2026/11/11 03:44:31 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-wikajoz7befa': Purge remote
--- PASS: TestMoveUnicodeEquivalentWithoutServerSideMove (8.17s)
=== RUN   TestCaseInsensitiveMoveWithoutServerSideMove
2026/11/11 03:44:31 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-varapon3hasu"
2026/11/11 03:44:31 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/11/11 03:44:31 DEBUG : Creating backend with remote "TestDrive:crypt/8ku1g1njjh6d7l26sl0bh2bk2qqs3rcio8nee305sosol8j8fp8g"
2026/11/11 03:44:32 DEBUG : Creating backend with remote "/tmp/rclone935630609"
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-varapon3hasu'", Local "Local file system at /tmp/rclone935630609", Modify Window "1ms"
    operations_test.go:1198: remote is case sensitive
2026/11/11 03:44:32 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-varapon3hasu': Purge remote
2026/11/11 03:44:33 NOTICE: purge failed: directory not found
--- SKIP: TestCaseInsensitiveMoveWithoutServerSideMove (1.15s)
=== RUN   TestCaseInsensitiveMoveFileDryRun
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
--- PASS: TestCaseInsensitiveMoveFileDryRun (0.59s)
=== RUN   TestMoveFileBackupDir
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:44:35 DEBUG : dst/file1: md5 = 746baaabf2a9781674dd7c68cb336964 OK
2026/11/11 03:44:36 DEBUG : Creating backend with remote "TestCryptDrive:rclone-test-pizimuq2poka/backup"
2026/11/11 03:44:36 DEBUG : Creating backend with remote "TestDrive:crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0/1nrff024r7pq65ecp72fc28jb0"
2026/11/11 03:44:37 DEBUG : dst/file1: size = 14 (Local file system at /tmp/rclone875949583)
2026/11/11 03:44:37 DEBUG : dst/file1: size = 18 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka')
2026/11/11 03:44:37 DEBUG : dst/file1: Sizes differ
2026/11/11 03:44:40 INFO  : dst/file1: Moved (server-side)
2026/11/11 03:44:41 DEBUG : dst/file1: md5 = 07cf25ad95cac0d81cfc84f53b206aaf OK
2026/11/11 03:44:41 DEBUG : dst/file1: size = 14 OK
2026/11/11 03:44:41 INFO  : dst/file1: Copied (new)
2026/11/11 03:44:41 INFO  : dst/file1: Deleted
--- PASS: TestMoveFileBackupDir (12.97s)
=== 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:44:48 DEBUG : A/file0: md5 = 53787488e1d49b5038486052e5434d1a OK
2026/11/11 03:44:50 DEBUG : A/file1: md5 = cff958d92e2261a3d2f88ed55023ccbc OK
2026/11/11 03:44:51 DEBUG : A/file2: md5 = c84e72707498e6105501786e770f7be5 OK
2026/11/11 03:44:52 DEBUG : A/file3: md5 = a01d6b646c0d3ce1c60c8c3eb802cb34 OK
2026/11/11 03:44:54 DEBUG : A/file4: md5 = d8e38a7972ac36245e558f397ebe22db OK
2026/11/11 03:44:55 DEBUG : A/file5: md5 = 071f0d96a8c9f68c903d0f6cd74da8f7 OK
2026/11/11 03:44:57 DEBUG : A/file6: md5 = f5a49c92f4e13d6d151b90e43683989d OK
2026/11/11 03:44:58 DEBUG : A/file7: md5 = 569176d9424a8dbebfe72d3dd40f2d16 OK
2026/11/11 03:45:00 DEBUG : A/file8: md5 = e61279f40ac26798f99a3af830a077bd OK
2026/11/11 03:45:01 DEBUG : A/file9: md5 = f981f6355959998c54b8ea557d065aa6 OK
2026/11/11 03:45:02 DEBUG : A/file10: md5 = 5d34810af911adf6d79d7c6f8b4efebb OK
2026/11/11 03:45:03 DEBUG : A/file11: md5 = 91b57ade1b437d3ab7fb21935906c8ef OK
2026/11/11 03:45:05 DEBUG : A/file12: md5 = eb7ab6fd056d5cb0080c6536ecf45964 OK
2026/11/11 03:45:06 DEBUG : A/file13: md5 = 821cfd60bac5662c0e10959932065365 OK
2026/11/11 03:45:08 DEBUG : A/file14: md5 = 31244e39b32251b6ffedf4bbb60b905d OK
2026/11/11 03:45:09 DEBUG : A/file15: md5 = 2ccd187368541a97a693393b1ff33219 OK
2026/11/11 03:45:11 DEBUG : A/file16: md5 = be41f599aac945371ba16da1d3a8f7a6 OK
2026/11/11 03:45:12 DEBUG : A/file17: md5 = b53b78e48f474243834fbc55ced26f73 OK
2026/11/11 03:45:13 DEBUG : A/file18: md5 = 7b6e3bebdce8f314863bf8ba31066bcd OK
2026/11/11 03:45:15 DEBUG : A/file19: md5 = 03d9ebd4e48a300dcf59803c99d2e61d OK
    operations_test.go:1563: Skipping test on non local remote
--- SKIP: TestDirMoveMoveError (39.34s)
=== RUN   TestDirMoveContext
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:45:28 DEBUG : A/one: md5 = 7f2b35d16aa333bf1aef48f2b53e1cb5 OK
2026/11/11 03:45:29 DEBUG : A/two: md5 = b9708b6b8d59955da9454e7489b4a331 OK
    operations_test.go:1563: Skipping test on non local remote
--- SKIP: TestDirMoveContext (5.85s)
=== RUN   TestDirMove
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:45:33 DEBUG : A1/one: md5 = 931b4404698a3b5dfc0916394d6fcef5 OK
2026/11/11 03:45:35 DEBUG : A1/two: md5 = a91610f4bec23a1ef8675a1294f4aa5e OK
2026/11/11 03:45:37 DEBUG : A1/B1/three: md5 = e63a72f7e70c8062f8b8770e7c5a938a OK
2026/11/11 03:45:39 DEBUG : A1/B1/C1/four: md5 = 2624dc9b353062661565df804d7eec37 OK
2026/11/11 03:45:41 DEBUG : A1/B1/C2/five: md5 = 9a93e52b1716df85800f0202d278e04f OK
2026/11/11 03:45:41 INFO  : A1/B2: Making directory
2026/11/11 03:45:41 INFO  : A1/B1/C3: Making directory
2026/11/11 03:45:51 INFO  : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four
2026/11/11 03:45:51 INFO  : A2/B1/three: Moved (server-side) to: A3/B1/three
2026/11/11 03:45:51 INFO  : A2/two: Moved (server-side) to: A3/two
2026/11/11 03:45:51 INFO  : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five
2026/11/11 03:45:51 INFO  : A2/one: Moved (server-side) to: A3/one
2026/11/11 03:45:56 INFO  : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2026/11/11 03:46:02 INFO  : A3/two: Moved (server-side) to: A4/two
2026/11/11 03:46:02 INFO  : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five
2026/11/11 03:46:02 INFO  : A3/B1/three: Moved (server-side) to: A4/B1/three
2026/11/11 03:46:02 INFO  : A3/one: Moved (server-side) to: A4/one
2026/11/11 03:46:03 INFO  : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four
--- PASS: TestDirMove (44.00s)
=== RUN   TestGetFsInfo
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:15 DEBUG : Config file has changed externally - reloading
--- PASS: TestGetFsInfo (0.55s)
=== RUN   TestRcat
=== RUN   TestRcat/withChecksum=false,ignoreChecksum=false
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:16 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': File to upload is small (34 bytes), uploading instead of streaming
2026/11/11 03:46:17 DEBUG : no_checksum_small_file_from_pipe: md5 = 75bd05f9746102f089d33dd8385b6882 OK
2026/11/11 03:46:17 DEBUG : no_checksum_small_file_from_pipe: size = 34 OK
2026/11/11 03:46:17 NOTICE: Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only
2026/11/11 03:46:17 DEBUG : no_checksum_small_file_from_pipe: Size of src and dst objects identical
2026/11/11 03:46:18 DEBUG : qc9k4uauqa9ls6a2r6lo8jf4b1m7r0510pkurois1cc70egbs4h0: Sending chunk 0 length 102465
2026/11/11 03:46:19 DEBUG : no_checksum_big_file_from_pipe: md5 = 55205538b08b759f63686b56ac9ce14b OK
2026/11/11 03:46:19 DEBUG : no_checksum_big_file_from_pipe: size = 102401 OK
2026/11/11 03:46:19 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:21 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': File to upload is small (34 bytes), uploading instead of streaming
2026/11/11 03:46:22 DEBUG : with_checksum_small_file_from_pipe: md5 = ce8934258f079c1205600c9f4b468e03 OK
2026/11/11 03:46:22 DEBUG : with_checksum_small_file_from_pipe: size = 34 OK
2026/11/11 03:46:22 DEBUG : with_checksum_small_file_from_pipe: Size of src and dst objects identical
2026/11/11 03:46:23 DEBUG : e74jo8a7lr1aimg2u78fct67gnuetc1qujiofaci0c8fnq7rjt1d4i296pcklqhgdihs03etvgdi4: Sending chunk 0 length 102465
2026/11/11 03:46:24 DEBUG : with_checksum_big_file_from_pipe: md5 = f5ee985eed632efa50d2897754a3de26 OK
2026/11/11 03:46:24 DEBUG : with_checksum_big_file_from_pipe: size = 102401 OK
2026/11/11 03:46:24 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:26 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': File to upload is small (34 bytes), uploading instead of streaming
2026/11/11 03:46:27 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK
2026/11/11 03:46:27 DEBUG : ignore_checksum_small_file_from_pipe: Size and modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/11 03:46:28 DEBUG : 1963rn6olajfbjn4nbqi9nacu7bk879vpf0d2bg8r0ndcqqsfntob0urt056p0qujf574rqnb5f62: Sending chunk 0 length 102465
2026/11/11 03:46:29 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK
2026/11/11 03:46:29 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:31 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': File to upload is small (34 bytes), uploading instead of streaming
2026/11/11 03:46:32 DEBUG : ignore_checksum_small_file_from_pipe: size = 34 OK
2026/11/11 03:46:32 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical
2026/11/11 03:46:33 DEBUG : 1963rn6olajfbjn4nbqi9nacu7bk879vpf0d2bg8r0ndcqqsfntob0urt056p0qujf574rqnb5f62: Sending chunk 0 length 102465
2026/11/11 03:46:33 DEBUG : ignore_checksum_big_file_from_pipe: size = 102401 OK
2026/11/11 03:46:33 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical
--- PASS: TestRcat (19.31s)
    --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (4.73s)
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (4.91s)
    --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (4.87s)
    --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (4.80s)
=== RUN   TestRcatMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
=== RUN   TestRcatMetadata/Normal
2026/11/11 03:46:35 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': File to upload is small (48 bytes), uploading instead of streaming
2026/11/11 03:46:37 DEBUG : rcat_metadata: md5 = 6fa90b48ce11a2fdc9c72639d59b5bf0 OK
2026/11/11 03:46:37 DEBUG : rcat_metadata: size = 48 OK
2026/11/11 03:46:37 DEBUG : rcat_metadata: Size of src and dst objects identical
=== RUN   TestRcatMetadata/ViaDisk
2026/11/11 03:46:38 DEBUG : rijssoobhbn85c5p1imhg55m6frank1nlplla6hkdjlqmqb2471g: Sending chunk 0 length 111
2026/11/11 03:46:39 DEBUG : rcat_metadata_uploadcutoff0: md5 = ba98aa032fea3aabe72df0eb59fdcba7 OK
2026/11/11 03:46:39 DEBUG : rcat_metadata_uploadcutoff0: size = 63 OK
2026/11/11 03:46:39 DEBUG : rcat_metadata_uploadcutoff0: Size of src and dst objects identical
--- PASS: TestRcatMetadata (5.33s)
    --- PASS: TestRcatMetadata/Normal (2.25s)
    --- PASS: TestRcatMetadata/ViaDisk (2.64s)
=== RUN   TestRcatSize
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:42 DEBUG : potato1: md5 = 9f4f386f2a1a7b1761a251305ac43e14 OK
2026/11/11 03:46:42 DEBUG : potato1: size = 60 OK
2026/11/11 03:46:42 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': File to upload is small (60 bytes), uploading instead of streaming
2026/11/11 03:46:44 DEBUG : potato2: md5 = 4ac8411f0ca54b18499544a95931b09b OK
2026/11/11 03:46:44 DEBUG : potato2: size = 60 OK
2026/11/11 03:46:44 DEBUG : potato2: Size of src and dst objects identical
--- PASS: TestRcatSize (4.77s)
=== RUN   TestRcatSizeShortEOF
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:47 DEBUG : potato1: md5 = 64943d304c996ed7cdf9e2fe7b91bbc8 OK
2026/11/11 03:46:47 DEBUG : potato1: size = 120 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka')
2026/11/11 03:46:47 DEBUG : potato1: size = 60 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka')
2026/11/11 03:46:47 ERROR : potato1: corrupted on transfer: sizes differ src 120 vs dst(Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka') 60
2026/11/11 03:46:47 INFO  : potato1: Removing failed copy
--- PASS: TestRcatSizeShortEOF (2.22s)
=== RUN   TestRcatSizeMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:49 DEBUG : potato1: md5 = 7670145fac80e2d358afe5b3c35f87b5 OK
2026/11/11 03:46:49 DEBUG : potato1: size = 60 OK
2026/11/11 03:46:49 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': File to upload is small (60 bytes), uploading instead of streaming
2026/11/11 03:46:50 DEBUG : potato2: md5 = 3b5a8ce9812f51ba19f9f01df0761f39 OK
2026/11/11 03:46:50 DEBUG : potato2: size = 60 OK
2026/11/11 03:46:50 DEBUG : potato2: Size of src and dst objects identical
--- PASS: TestRcatSizeMetadata (4.89s)
=== RUN   TestRcatSizeUploadHeaders
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:54 DEBUG : potato1: md5 = 0f43daf12aca8b41834663226123df19 OK
2026/11/11 03:46:54 DEBUG : potato1: size = 60 OK
--- PASS: TestRcatSizeUploadHeaders (2.26s)
=== RUN   TestRcatSizeChecksum
=== RUN   TestRcatSizeChecksum/Corrupted
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", 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-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:56 DEBUG : potato4: md5 = fd0740901307fa952b26a34fdf62b254 OK
2026/11/11 03:46:56 DEBUG : potato4: size = 60 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka')
2026/11/11 03:46:56 DEBUG : potato4: size = 59 (Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka')
2026/11/11 03:46:56 ERROR : potato4: corrupted on transfer: sizes differ src 60 vs dst(Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka') 59
2026/11/11 03:46:56 INFO  : potato4: Removing failed copy
=== RUN   TestRcatSizeChecksum/IgnoreChecksum
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:46:59 DEBUG : potato2: size = 60 OK
=== RUN   TestRcatSizeChecksum/NoHashes
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:47:02 DEBUG : potato3: md5 = 87e2543aa1d39642f3558f6171fb23b5 OK
2026/11/11 03:47:02 DEBUG : potato3: size = 60 OK
--- PASS: TestRcatSizeChecksum (7.82s)
    --- SKIP: TestRcatSizeChecksum/Corrupted (0.43s)
    --- PASS: TestRcatSizeChecksum/SizeDiffers (2.57s)
    --- PASS: TestRcatSizeChecksum/IgnoreChecksum (2.56s)
    --- PASS: TestRcatSizeChecksum/NoHashes (2.26s)
=== RUN   TestTouchDir
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:47:04 DEBUG : potato2: md5 = e75240bf5531687200fd026060ebcac6 OK
2026/11/11 03:47:05 DEBUG : empty space: md5 = f8528aa11f811082ca85ec8c5248760e OK
2026/11/11 03:47:07 DEBUG : sub dir/potato3: md5 = 473e98776947f1c1a04df0580b57a3c8 OK
2026/11/11 03:47:08 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Touching "sub dir/potato3"
2026/11/11 03:47:08 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Touching "empty space"
2026/11/11 03:47:08 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Touching "potato2"
--- PASS: TestTouchDir (10.18s)
=== RUN   TestMkdirMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:47:13 DEBUG : dir with metadata: Making directory with metadata
2026/11/11 03:47:13 INFO  : dir with metadata: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
--- PASS: TestMkdirMetadata (2.32s)
=== RUN   TestMkdirModTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:47:15 DEBUG : directory with modtime: Making directory with metadata
2026/11/11 03:47:16 INFO  : directory with modtime: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/11/11 03:47:16 NOTICE: dry run directory with modtime: Skipped make directory as --dry-run is set
--- PASS: TestMkdirModTime (2.23s)
=== RUN   TestCopyDirMetadata
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:47:17 DEBUG : dir with metadata to be copied: Making directory with metadata
2026/11/11 03:47:17 INFO  : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/11/11 03:47:17 DEBUG : Google drive root 'crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0': Skipping btime metadata as can't update it on an existing file: 2026-11-11T03:47:17.661053985Z
2026/11/11 03:47:18 INFO  : non existent directory: Updated directory metadata
2026/11/11 03:47:20 DEBUG : Google drive root 'crypt/b2m0ffd2op3aa1ejufm0hvggdnam58ve1eede8r0amkinilhn6r0': Skipping btime metadata as can't update it on an existing file: 2026-11-11T03:47:17.661053985Z
2026/11/11 03:47:20 INFO  : existing directory: Updated directory metadata
--- PASS: TestCopyDirMetadata (4.78s)
=== RUN   TestSetDirModTime
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:47:22 DEBUG : set modtime on non existent directory: Skipping set directory modification time as --no-update-dir-modtime is set
2026/11/11 03:47:23 INFO  : set modtime on existing directory: Set directory modification time (using SetModTime)
2026/11/11 03:47:24 INFO  : set modtime on existing directory: Set directory modification time (using DirSetModTime)
--- PASS: TestSetDirModTime (3.99s)
=== RUN   TestDirsEqual
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:47:26 DEBUG : dir with metadata to be copied: Making directory with metadata
2026/11/11 03:47:26 INFO  : dir with metadata to be copied: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/11/11 03:47:26 DEBUG : dst: Making directory with metadata
2026/11/11 03:47:27 INFO  : dst: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z)
2026/11/11 03:47:27 DEBUG : dst: Directory modification time the same (differ by -999.999µs, within tolerance 1ms)
2026/11/11 03:47:27 INFO  : dst: Set directory modification time (using SetModTime)
2026/11/11 03:47:27 INFO  : dst: Set directory modification time (using SetModTime)
2026/11/11 03:47:27 DEBUG : dst: Directory modification time the same (differ by 1ns, within tolerance 1ms)
2026/11/11 03:47:28 INFO  : dst: Set directory modification time (using SetModTime)
2026/11/11 03:47:28 DEBUG : dst: Destination directory is newer than source, skipping
--- PASS: TestDirsEqual (3.50s)
=== RUN   TestRemoveExisting
    run.go:198: Remote "Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka'", Local "Local file system at /tmp/rclone875949583", Modify Window "1ms"
2026/11/11 03:47:31 DEBUG : sub dir/test remove existing: md5 = f961a4d8b5e7a10180714b48d1e78ae0 OK
2026/11/11 03:47:33 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: md5 = 75d15eb7d7efb2b0bd7a8e0a1397ce9f OK
2026/11/11 03:47:35 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.zoboyaj3" before starting
2026/11/11 03:47:36 DEBUG : sub dir/test remove existing.zoboyaj3: TEST: removing renamed existing file after operation
2026/11/11 03:47: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.xuvimep5" before starting
2026/11/11 03:47:38 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.xuvimep5: TEST: renaming existing back after failed operation
2026/11/11 03:47:39 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.wazohox3" before starting
2026/11/11 03:47:40 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.wazohox3: TEST: removing renamed existing file after operation
--- PASS: TestRemoveExisting (12.87s)
=== RUN   TestRcatInputFailurePreservesDestination
2026/11/11 03:47:42 DEBUG : Creating backend with remote "/tmp/TestRcatInputFailurePreservesDestination536456840/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/11 03:47:42 DEBUG : Encrypted drive 'TestCryptDrive:rclone-test-pizimuq2poka': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptDrive: -verbose -fast-list" - Finished OK in 21m14.659942062s (try 1/5)