"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 4/5)
2025/06/27 07:12:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha"
2025/06/27 07:12:24 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/06/27 07:12:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha.bin"
2025/06/27 07:12:25 DEBUG : Swift container crypt path rclone-test-wediner7qeha.bin: Auto set use_segments_container to true
2025/06/27 07:12:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha"
2025/06/27 07:12:30 DEBUG : Swift container crypt path rclone-test-wediner7qeha: Auto set use_segments_container to true
2025/06/27 07:12:36 DEBUG : Creating backend with remote "/tmp/rclone1507986760"
=== RUN   TestPipe
--- PASS: TestPipe (0.00s)
=== RUN   TestPipeConcurrent
--- PASS: TestPipeConcurrent (0.04s)
=== RUN   TestPipeOrderBy
=== RUN   TestPipeOrderBy/#00
=== RUN   TestPipeOrderBy/size
=== RUN   TestPipeOrderBy/name
=== RUN   TestPipeOrderBy/modtime
=== RUN   TestPipeOrderBy/size,ascending
=== RUN   TestPipeOrderBy/name,asc
=== RUN   TestPipeOrderBy/modtime,ascending
=== RUN   TestPipeOrderBy/size,descending
=== RUN   TestPipeOrderBy/name,desc
=== RUN   TestPipeOrderBy/modtime,descending
=== RUN   TestPipeOrderBy/size,mixed,50
=== RUN   TestPipeOrderBy/size,mixed,51
--- PASS: TestPipeOrderBy (0.00s)
    --- PASS: TestPipeOrderBy/#00 (0.00s)
    --- PASS: TestPipeOrderBy/size (0.00s)
    --- PASS: TestPipeOrderBy/name (0.00s)
    --- PASS: TestPipeOrderBy/modtime (0.00s)
    --- PASS: TestPipeOrderBy/size,ascending (0.00s)
    --- PASS: TestPipeOrderBy/name,asc (0.00s)
    --- PASS: TestPipeOrderBy/modtime,ascending (0.00s)
    --- PASS: TestPipeOrderBy/size,descending (0.00s)
    --- PASS: TestPipeOrderBy/name,desc (0.00s)
    --- PASS: TestPipeOrderBy/modtime,descending (0.00s)
    --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s)
    --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s)
=== RUN   TestNewLess
=== RUN   TestNewLess/blankOK
=== RUN   TestNewLess/tooManyParts
=== RUN   TestNewLess/tooManyParts2
=== RUN   TestNewLess/badMixed
=== RUN   TestNewLess/unknownComparison
=== RUN   TestNewLess/unknownSortDirection
=== RUN   TestNewLess/size
=== RUN   TestNewLess/name
=== RUN   TestNewLess/modtime
=== RUN   TestNewLess/size,ascending
=== RUN   TestNewLess/name,asc
=== RUN   TestNewLess/modtime,ascending
=== RUN   TestNewLess/size,descending
=== RUN   TestNewLess/name,desc
=== RUN   TestNewLess/modtime,descending
=== RUN   TestNewLess/modtime,mixed
=== RUN   TestNewLess/modtime,mixed,30
--- PASS: TestNewLess (0.00s)
    --- PASS: TestNewLess/blankOK (0.00s)
    --- PASS: TestNewLess/tooManyParts (0.00s)
    --- PASS: TestNewLess/tooManyParts2 (0.00s)
    --- PASS: TestNewLess/badMixed (0.00s)
    --- PASS: TestNewLess/unknownComparison (0.00s)
    --- PASS: TestNewLess/unknownSortDirection (0.00s)
    --- PASS: TestNewLess/size (0.00s)
    --- PASS: TestNewLess/name (0.00s)
    --- PASS: TestNewLess/modtime (0.00s)
    --- PASS: TestNewLess/size,ascending (0.00s)
    --- PASS: TestNewLess/name,asc (0.00s)
    --- PASS: TestNewLess/modtime,ascending (0.00s)
    --- PASS: TestNewLess/size,descending (0.00s)
    --- PASS: TestNewLess/name,desc (0.00s)
    --- PASS: TestNewLess/modtime,descending (0.00s)
    --- PASS: TestNewLess/modtime,mixed (0.00s)
    --- PASS: TestNewLess/modtime,mixed,30 (0.00s)
=== RUN   TestRcCopy
    rc_test.go:16: Skipping test on non local remote
--- SKIP: TestRcCopy (0.00s)
=== RUN   TestRcMove
    rc_test.go:16: Skipping test on non local remote
--- SKIP: TestRcMove (0.00s)
=== RUN   TestRcSync
    rc_test.go:16: Skipping test on non local remote
--- SKIP: TestRcSync (0.00s)
=== RUN   TestCopyWithDryRun
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:12:36 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:12:36 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11)
2025/06/27 07:12:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:12:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
--- PASS: TestCopyWithDryRun (0.39s)
=== RUN   TestCopy
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:12:36 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/06/27 07:12:36 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:12:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:12:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:12:41 DEBUG : sub dir/hello world: md5 = c398d114c35794b40f437a396e6ab1bd OK
2025/06/27 07:12:41 INFO  : sub dir/hello world: Copied (new)
2025/06/27 07:12:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestCopy (21.03s)
=== RUN   TestCopyMetadata
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:98: Skipping as metadata not supported
--- SKIP: TestCopyMetadata (0.10s)
=== RUN   TestCopyMetadataNoEmptyDirs
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:98: Skipping as metadata not supported
--- SKIP: TestCopyMetadataNoEmptyDirs (0.37s)
=== RUN   TestCopyMissingDirectory
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:12:57 DEBUG : Creating backend with remote "/non-existing"
2025/06/27 07:12:58 ERROR : Local file system at /non-existing: error reading source root directory: directory not found
2025/06/27 07:12:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:12:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
--- PASS: TestCopyMissingDirectory (0.13s)
=== RUN   TestCopyNoTraverse
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:13:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:13:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:13:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:13:08 DEBUG : sub dir/hello world: md5 = 47089ad29126291799ea820be7bc88e6 OK
2025/06/27 07:13:08 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyNoTraverse (20.71s)
=== RUN   TestCopyCheckFirst
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:13:18 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Running all checks before starting transfers
2025/06/27 07:13:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:13:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:13:18 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Checks finished, now starting transfers
2025/06/27 07:13:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:13:23 DEBUG : sub dir/hello world: md5 = d043a2d4d25e92d87f48ac32a76faa3f OK
2025/06/27 07:13:23 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyCheckFirst (20.73s)
=== RUN   TestSyncNoTraverse
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:13:39 ERROR : Ignoring --no-traverse with sync
2025/06/27 07:13:39 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:13:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:13:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:13:44 DEBUG : sub dir/hello world: md5 = 41a0c1054558786711444bbbd5e62bc9 OK
2025/06/27 07:13:44 INFO  : sub dir/hello world: Copied (new)
2025/06/27 07:13:44 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoTraverse (15.83s)
=== RUN   TestCopyWithDepth
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:13:55 DEBUG : hello world2: Need to transfer - File not found at Destination
2025/06/27 07:13:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:13:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:14:00 DEBUG : hello world2: md5 = 7f1d94cb361b304b4a91a7c3cd86ab48 OK
2025/06/27 07:14:00 INFO  : hello world2: Copied (new)
--- PASS: TestCopyWithDepth (15.92s)
=== RUN   TestCopyWithFilesFrom
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:14:11 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:14:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:14:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:14:11 DEBUG : potato2: md5 = c6d25ba240227bd95f6cbfee5b84cd75 OK
2025/06/27 07:14:11 INFO  : potato2: Copied (new)
--- PASS: TestCopyWithFilesFrom (1.12s)
=== RUN   TestCopyWithFilesFromAndNoTraverse
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:14:17 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:14:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:14:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:14:17 DEBUG : potato2: md5 = c65a38224b3d452407c21fc734675332 OK
2025/06/27 07:14:17 INFO  : potato2: Copied (new)
--- PASS: TestCopyWithFilesFromAndNoTraverse (6.23s)
=== RUN   TestCopyEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:14:18 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2025/06/27 07:14:18 INFO  : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/06/27 07:14:18 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2025/06/27 07:14:18 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/06/27 07:14:18 INFO  : sub dir2: Making directory
2025/06/27 07:14:18 INFO  : sub dir: Making directory
2025/06/27 07:14:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:14:18 INFO  : sub dir2/sub sub dir2: Making directory
2025/06/27 07:14:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:14:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:14:23 DEBUG : sub dir/hello world: md5 = ac5636438af158d227490b2b5f629f24 OK
2025/06/27 07:14:23 INFO  : sub dir/hello world: Copied (new)
    fstest.go:247: Filtering empty directory "sub dir2"
    fstest.go:247: Filtering empty directory "sub dir2/sub sub dir2"
2025/06/27 07:14:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestCopyEmptyDirectories (10.87s)
=== RUN   TestCopyNoEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:14:29 INFO  : sub dir2: Making directory
2025/06/27 07:14:29 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2025/06/27 07:14:29 INFO  : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/06/27 07:14:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:14:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:14:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:14:34 DEBUG : sub dir/hello world: md5 = 8f58ace5d89f6f40d9ad5e9e6415c582 OK
2025/06/27 07:14:34 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyNoEmptyDirectories (15.84s)
=== RUN   TestMoveEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:14:45 DEBUG : sub dir2: Making directory with metadata
2025/06/27 07:14:45 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/06/27 07:14:45 INFO  : sub dir2: Making directory
2025/06/27 07:14:45 INFO  : sub dir: Making directory
2025/06/27 07:14:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:14:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:14:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:14:50 DEBUG : sub dir/hello world: md5 = 64ea4cc23a14ef1da9be0d614199c977 OK
2025/06/27 07:14:50 INFO  : sub dir/hello world: Copied (new)
2025/06/27 07:14:50 INFO  : sub dir/hello world: Deleted
    fstest.go:247: Filtering empty directory "sub dir2"
2025/06/27 07:14:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
2025/06/27 07:14:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestMoveEmptyDirectories (10.96s)
=== RUN   TestSyncNoUpdateDirModtime
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:409: Skipping test as backend does not support DirSetModTime
--- SKIP: TestSyncNoUpdateDirModtime (0.33s)
=== RUN   TestMoveNoEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:14:56 INFO  : sub dir2: Making directory
2025/06/27 07:14:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:14:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:14:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:15:01 DEBUG : sub dir/hello world: md5 = 4bb34bf98aebc600d26324e6eb4fe5b7 OK
2025/06/27 07:15:01 INFO  : sub dir/hello world: Copied (new)
2025/06/27 07:15:01 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveNoEmptyDirectories (10.68s)
=== RUN   TestSyncEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:15:07 DEBUG : sub dir2: Making directory with metadata
2025/06/27 07:15:07 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/06/27 07:15:07 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/06/27 07:15:07 INFO  : sub dir2: Making directory
2025/06/27 07:15:07 INFO  : sub dir: Making directory
2025/06/27 07:15:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:15:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:15:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:15:12 DEBUG : sub dir/hello world: md5 = d1690aaedbd8084fe5188ca9cb236634 OK
2025/06/27 07:15:12 INFO  : sub dir/hello world: Copied (new)
2025/06/27 07:15:12 DEBUG : Waiting for deletions to finish
    fstest.go:247: Filtering empty directory "sub dir2"
2025/06/27 07:15:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestSyncEmptyDirectories (13.84s)
=== RUN   TestSyncSetDelayedModTimes
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:508: Backend doesn't have DirModTimeUpdatesOnWrite set
--- SKIP: TestSyncSetDelayedModTimes (0.19s)
=== RUN   TestSyncNoEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:15:21 INFO  : sub dir2: Making directory
2025/06/27 07:15:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:15:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:15:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:15:26 DEBUG : sub dir/hello world: md5 = e29d075800e5bf55e2f2927ef1fd49d4 OK
2025/06/27 07:15:26 INFO  : sub dir/hello world: Copied (new)
2025/06/27 07:15:26 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoEmptyDirectories (10.95s)
=== RUN   TestServerSideCopy
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:15:37 DEBUG : sub dir/hello world: md5 = b946012dbcf8dbefedbfeb02202cf161 OK
2025/06/27 07:15:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-binowiz5zupe"
2025/06/27 07:15:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-binowiz5zupe.bin"
2025/06/27 07:15:43 DEBUG : Swift container crypt path rclone-test-binowiz5zupe.bin: Auto set use_segments_container to true
2025/06/27 07:16:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-binowiz5zupe"
2025/06/27 07:16:03 DEBUG : Swift container crypt path rclone-test-binowiz5zupe: Auto set use_segments_container to true
    sync_test.go:591: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha' -> Encrypted drive 'TestCryptSwift:rclone-test-binowiz5zupe'
2025/06/27 07:16:14 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:16:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-binowiz5zupe': Waiting for checks to finish
2025/06/27 07:16:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-binowiz5zupe': Waiting for transfers to finish
2025/06/27 07:16:24 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/27 07:16:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-binowiz5zupe': Purge remote
2025/06/27 07:16:24 DEBUG : Waiting for deletions to finish
2025/06/27 07:16:30 INFO  : sub dir/hello world.bin: Deleted
--- PASS: TestServerSideCopy (63.22s)
=== RUN   TestCopyOverSelf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:16:40 DEBUG : sub dir/hello world: md5 = 10fe0f0e96b9a6f73bcf261e4838de62 OK
2025/06/27 07:16:46 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/06/27 07:16:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:16:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:16:51 DEBUG : sub dir/hello world: md5 = c5143483cd1b6fef06543f49980b98c6 OK
2025/06/27 07:16:51 INFO  : sub dir/hello world: Copied (replaced existing)
--- PASS: TestCopyOverSelf (31.71s)
=== RUN   TestServerSideCopyOverSelf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:17:12 DEBUG : sub dir/hello world: md5 = e0e42dec09cf63860a142c7cab3509cb OK
2025/06/27 07:17:12 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-serutoc6veli"
2025/06/27 07:17:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-serutoc6veli.bin"
2025/06/27 07:17:12 DEBUG : Swift container crypt path rclone-test-serutoc6veli.bin: Auto set use_segments_container to true
2025/06/27 07:17:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-serutoc6veli"
2025/06/27 07:17:18 DEBUG : Swift container crypt path rclone-test-serutoc6veli: Auto set use_segments_container to true
    sync_test.go:627: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha' -> Encrypted drive 'TestCryptSwift:rclone-test-serutoc6veli'
2025/06/27 07:17:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:17:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-serutoc6veli': Waiting for checks to finish
2025/06/27 07:17:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-serutoc6veli': Waiting for transfers to finish
2025/06/27 07:17:39 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/27 07:17:44 DEBUG : sub dir/hello world: md5 = f692db13f3044e6b87e7ecf000880cf2 OK
2025/06/27 07:17:45 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/06/27 07:17:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-serutoc6veli': Waiting for checks to finish
2025/06/27 07:17:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-serutoc6veli': Waiting for transfers to finish
2025/06/27 07:17:55 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/27 07:17:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-serutoc6veli': Purge remote
2025/06/27 07:17:55 DEBUG : Waiting for deletions to finish
2025/06/27 07:18:00 INFO  : sub dir/hello world.bin: Deleted
--- PASS: TestServerSideCopyOverSelf (59.04s)
=== RUN   TestMoveOverSelf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:18:11 DEBUG : sub dir/hello world: md5 = 29cb5d5b70b0f131eee87b4d05fbb4ba OK
2025/06/27 07:18:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:18:16 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/06/27 07:18:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:18:26 DEBUG : sub dir/hello world: md5 = dcbf60cfd25bba3265a1d88efdd6635f OK
2025/06/27 07:18:26 INFO  : sub dir/hello world: Copied (replaced existing)
2025/06/27 07:18:26 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveOverSelf (26.40s)
=== RUN   TestServerSideMoveOverSelf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:18:37 DEBUG : sub dir/hello world: md5 = c7b2d01dc530a1b216a0ded2f0972f56 OK
2025/06/27 07:18:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-liyolap8buqu"
2025/06/27 07:18:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-liyolap8buqu.bin"
2025/06/27 07:18:38 DEBUG : Swift container crypt path rclone-test-liyolap8buqu.bin: Auto set use_segments_container to true
2025/06/27 07:18:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-liyolap8buqu"
2025/06/27 07:18:44 DEBUG : Swift container crypt path rclone-test-liyolap8buqu: Auto set use_segments_container to true
    sync_test.go:672: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha' -> Encrypted drive 'TestCryptSwift:rclone-test-liyolap8buqu'
2025/06/27 07:18:57 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:18:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyolap8buqu': Waiting for checks to finish
2025/06/27 07:18:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyolap8buqu': Waiting for transfers to finish
2025/06/27 07:19:18 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/27 07:19:23 DEBUG : sub dir/hello world: md5 = 4c5d314d27a694546eea0d707172758e OK
2025/06/27 07:19:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyolap8buqu': Waiting for checks to finish
2025/06/27 07:19:23 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/06/27 07:19:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyolap8buqu': Waiting for transfers to finish
2025/06/27 07:19:44 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/27 07:19:49 INFO  : sub dir/hello world: Deleted
2025/06/27 07:19:54 DEBUG : sub dir/hello world: md5 = 9e1fdd2ecc7daa4c886248d6381071f5 OK
2025/06/27 07:19:54 DEBUG : testing file moves
2025/06/27 07:19:55 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17)
2025/06/27 07:19:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyolap8buqu': Waiting for checks to finish
2025/06/27 07:19:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyolap8buqu': Waiting for transfers to finish
2025/06/27 07:20:00 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/27 07:20:05 INFO  : sub dir/hello world: Deleted
2025/06/27 07:20:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyolap8buqu': Purge remote
2025/06/27 07:20:05 DEBUG : Waiting for deletions to finish
2025/06/27 07:20:06 INFO  : sub dir/hello world.bin: Deleted
--- PASS: TestServerSideMoveOverSelf (93.72s)
=== RUN   TestCopyAfterDelete
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:20:11 DEBUG : sub dir/hello world: md5 = 148262d6b534bdf7aac56ab8260a2a67 OK
2025/06/27 07:20:11 ERROR : error listing: directory not found
2025/06/27 07:20:16 INFO  : Local file system at /tmp/rclone1507986760: Making directory
2025/06/27 07:20:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:20:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
--- PASS: TestCopyAfterDelete (21.11s)
=== RUN   TestCopyRedownload
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:20:32 DEBUG : sub dir/hello world: md5 = 2cf6aaf83bf40c54c169ea20840c92b8 OK
2025/06/27 07:20:33 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:20:33 DEBUG : Local file system at /tmp/rclone1507986760: Waiting for checks to finish
2025/06/27 07:20:33 DEBUG : Local file system at /tmp/rclone1507986760: Waiting for transfers to finish
2025/06/27 07:20:38 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/06/27 07:20:38 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyRedownload (16.02s)
=== RUN   TestSyncBasedOnCheckSum
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:20:43 DEBUG : check sum: Need to transfer - File not found at Destination
2025/06/27 07:20:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:20:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:20:48 DEBUG : check sum: md5 = 4f6b4331338cd60d60f93c03227d410a OK
2025/06/27 07:20:48 INFO  : check sum: Copied (new)
2025/06/27 07:20:48 DEBUG : Waiting for deletions to finish
2025/06/27 07:20:49 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only
2025/06/27 07:20:49 DEBUG : check sum: Size of src and dst objects identical
2025/06/27 07:20:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:20:49 DEBUG : check sum: Unchanged skipping
2025/06/27 07:20:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:20:49 DEBUG : Waiting for deletions to finish
2025/06/27 07:20:49 INFO  : There was nothing to transfer
--- PASS: TestSyncBasedOnCheckSum (11.25s)
=== RUN   TestSyncSizeOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:20:54 DEBUG : sizeonly: Need to transfer - File not found at Destination
2025/06/27 07:20:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:20:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:21:00 DEBUG : sizeonly: md5 = 89e2f1ee6f9b034e95d0f03d2fcdece1 OK
2025/06/27 07:21:00 INFO  : sizeonly: Copied (new)
2025/06/27 07:21:00 DEBUG : Waiting for deletions to finish
2025/06/27 07:21:05 DEBUG : sizeonly: Sizes identical
2025/06/27 07:21:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:21:05 DEBUG : sizeonly: Unchanged skipping
2025/06/27 07:21:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:21:05 DEBUG : Waiting for deletions to finish
2025/06/27 07:21:05 INFO  : There was nothing to transfer
--- PASS: TestSyncSizeOnly (16.01s)
=== RUN   TestSyncIgnoreSize
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:21:10 DEBUG : ignore-size: Need to transfer - File not found at Destination
2025/06/27 07:21:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:21:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:21:11 DEBUG : ignore-size: md5 = 87e0035ca0eb740295665c163c311296 OK
2025/06/27 07:21:11 INFO  : ignore-size: Copied (new)
2025/06/27 07:21:11 DEBUG : Waiting for deletions to finish
2025/06/27 07:21:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:21:11 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:21:11 DEBUG : ignore-size: Unchanged skipping
2025/06/27 07:21:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:21:11 DEBUG : Waiting for deletions to finish
2025/06/27 07:21:11 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreSize (1.07s)
=== RUN   TestSyncIgnoreTimes
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:21:17 DEBUG : existing: md5 = c3d9eb35d24d3a6147236fcb164c86a8 OK
2025/06/27 07:21:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:21:17 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:21:17 DEBUG : existing: Unchanged skipping
2025/06/27 07:21:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:21:17 DEBUG : Waiting for deletions to finish
2025/06/27 07:21:17 INFO  : There was nothing to transfer
2025/06/27 07:21:17 DEBUG : existing: Transferring unconditionally as --ignore-times is in use
2025/06/27 07:21:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:21:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:21:22 DEBUG : existing: md5 = 9a013dfab0058ebe4add87d770a6fb88 OK
2025/06/27 07:21:22 INFO  : existing: Copied (replaced existing)
2025/06/27 07:21:22 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncIgnoreTimes (16.62s)
=== RUN   TestSyncIgnoreExisting
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:21:28 DEBUG : existing: Need to transfer - File not found at Destination
2025/06/27 07:21:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:21:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:21:33 DEBUG : existing: md5 = 5147b7e25a5dd99b064da41f98252946 OK
2025/06/27 07:21:33 INFO  : existing: Copied (new)
2025/06/27 07:21:33 DEBUG : Waiting for deletions to finish
2025/06/27 07:21:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:21:34 DEBUG : existing: Destination exists, skipping
2025/06/27 07:21:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:21:34 DEBUG : Waiting for deletions to finish
2025/06/27 07:21:34 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreExisting (10.95s)
=== RUN   TestSyncIgnoreErrors
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:21:39 DEBUG : b/potato: md5 = 72c40877c459f1031c8fd0d3b230d891 OK
2025/06/27 07:21:45 DEBUG : c/non empty space: md5 = 36059540c53824b3355f1d2a35dbf9c4 OK
2025/06/27 07:21:45 INFO  : d: Making directory
    fstest.go:247: Filtering empty directory "d"
2025/06/27 07:21:45 DEBUG : a/potato2: Need to transfer - File not found at Destination
2025/06/27 07:21:45 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:21:45 DEBUG : c/non empty space: Unchanged skipping
2025/06/27 07:21:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:21:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:21:46 DEBUG : a/potato2: md5 = 6be1430f9394a2d977e5e657143d541f OK
2025/06/27 07:21:46 INFO  : a/potato2: Copied (new)
2025/06/27 07:21:46 DEBUG : Waiting for deletions to finish
2025/06/27 07:21:46 INFO  : b/potato: Deleted
--- PASS: TestSyncIgnoreErrors (13.09s)
=== RUN   TestSyncAfterChangingModtimeOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:21:57 DEBUG : empty space: md5 = 41d22175c5e6402395a320426e7d939b OK
2025/06/27 07:22:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:22:03 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC
2025/06/27 07:22:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:22:03 NOTICE: empty space: Skipped copy as --dry-run is set (size 1)
2025/06/27 07:22:03 DEBUG : Waiting for deletions to finish
2025/06/27 07:22:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:22:13 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC
2025/06/27 07:22:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:22:18 DEBUG : empty space: md5 = 610c6a35d2ab6067092982417c565bd9 OK
2025/06/27 07:22:18 INFO  : empty space: Copied (replaced existing)
2025/06/27 07:22:18 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingModtimeOnly (36.76s)
=== RUN   TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:1017: Can't check this if no hashes supported
--- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.23s)
=== RUN   TestSyncDoesntUpdateModtime
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:22:30 DEBUG : foo: md5 = 99ce11afdbba9cd45246f96c971d4585 OK
2025/06/27 07:22:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:22:31 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC
2025/06/27 07:22:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:22:31 DEBUG : foo: md5 = cd2904148e47e353414a5de66d62a2e4 OK
2025/06/27 07:22:31 INFO  : foo: Copied (replaced existing)
2025/06/27 07:22:31 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncDoesntUpdateModtime (2.59s)
=== RUN   TestSyncAfterAddingAFile
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:22:37 DEBUG : empty space: md5 = b01c18fda44eebceded8d775b8594b2b OK
2025/06/27 07:22:37 DEBUG : potato: Need to transfer - File not found at Destination
2025/06/27 07:22:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:22:37 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:22:37 DEBUG : empty space: Unchanged skipping
2025/06/27 07:22:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:22:42 DEBUG : potato: md5 = 5efb43555c77f3c2b4534f2a64a33034 OK
2025/06/27 07:22:42 INFO  : potato: Copied (new)
2025/06/27 07:22:42 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterAddingAFile (26.68s)
=== RUN   TestSyncAfterChangingFilesSizeOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:23:03 DEBUG : potato: md5 = 03a9a2f83e229f35732cc7ec37c27275 OK
2025/06/27 07:23:04 DEBUG : potato: Sizes differ (src 21 vs dst 60)
2025/06/27 07:23:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:23:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:23:14 DEBUG : potato: md5 = 7da4d1f5eb1fbb4163c459167396c573 OK
2025/06/27 07:23:14 INFO  : potato: Copied (replaced existing)
2025/06/27 07:23:14 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingFilesSizeOnly (26.28s)
=== RUN   TestSyncAfterChangingContentsOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:23:30 DEBUG : potato: md5 = 9ac136b993dab7ea4ded5db567f72176 OK
2025/06/27 07:23:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:23:30 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC
2025/06/27 07:23:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:23:35 DEBUG : potato: md5 = ce2d1023fd15eaef985b88e433d58096 OK
2025/06/27 07:23:35 INFO  : potato: Copied (replaced existing)
2025/06/27 07:23:35 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingContentsOnly (16.28s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileDryRun
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:23:46 DEBUG : potato: md5 = 2881f81ea00b8a333382ec9aebd63482 OK
2025/06/27 07:23:51 DEBUG : empty space: md5 = c439ec113b152fa7d9d84b76508c022d OK
2025/06/27 07:23:51 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:23:51 NOTICE: potato2: Skipped copy as --dry-run is set (size 60)
2025/06/27 07:23:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:23:51 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:23:51 DEBUG : empty space: Unchanged skipping
2025/06/27 07:23:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:23:51 DEBUG : Waiting for deletions to finish
2025/06/27 07:23:51 NOTICE: potato: Skipped delete as --dry-run is set (size 21)
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (26.33s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFile
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:24:12 DEBUG : potato: md5 = dd7b80624422c82db04851c55a6ff000 OK
2025/06/27 07:24:17 DEBUG : empty space: md5 = c078e463557108c789ab032031318fae OK
2025/06/27 07:24:23 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:24:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:24:23 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:24:23 DEBUG : empty space: Unchanged skipping
2025/06/27 07:24:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:24:23 DEBUG : potato2: md5 = d356e476c7dbb1261c487e88206d2767 OK
2025/06/27 07:24:23 INFO  : potato2: Copied (new)
2025/06/27 07:24:23 DEBUG : Waiting for deletions to finish
2025/06/27 07:24:28 INFO  : potato: Deleted
--- PASS: TestSyncAfterRemovingAFileAndAddingAFile (36.98s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDir
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:24:44 DEBUG : b/potato: md5 = 303eaf5f59e027dedc7a987a8f5f5fdc OK
2025/06/27 07:24:50 DEBUG : c/non empty space: md5 = ca0141c475bf758a1e538bb8100e39f1 OK
2025/06/27 07:24:50 INFO  : d: Making directory
2025/06/27 07:24:50 INFO  : d/e: Making directory
    fstest.go:247: Filtering empty directory "d"
    fstest.go:247: Filtering empty directory "d/e"
2025/06/27 07:24:50 DEBUG : a/potato2: Need to transfer - File not found at Destination
2025/06/27 07:24:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:24:50 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:24:50 DEBUG : c/non empty space: Unchanged skipping
2025/06/27 07:24:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:24:50 DEBUG : a/potato2: md5 = 554a32a3f78e32adf72d752e4d3979bf OK
2025/06/27 07:24:50 INFO  : a/potato2: Copied (new)
2025/06/27 07:24:50 DEBUG : Waiting for deletions to finish
2025/06/27 07:24:51 INFO  : b/potato: Deleted
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (12.38s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:24:57 DEBUG : b/potato: md5 = e0ebb084215da038066ee2c0d5949df0 OK
2025/06/27 07:25:02 DEBUG : c/non empty space: md5 = d7bf499423036e891de19c43374372da OK
2025/06/27 07:25:02 INFO  : d: Making directory
    fstest.go:247: Filtering empty directory "d"
2025/06/27 07:25:02 DEBUG : a/potato2: Need to transfer - File not found at Destination
2025/06/27 07:25:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:25:03 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:25:03 DEBUG : c/non empty space: Unchanged skipping
2025/06/27 07:25:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:25:03 DEBUG : a/potato2: md5 = daa3283d0581143bd4ce44747eee8c3f OK
2025/06/27 07:25:03 INFO  : a/potato2: Copied (new)
2025/06/27 07:25:03 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': not deleting files as there were IO errors
2025/06/27 07:25:03 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': not deleting directories as there were IO errors
    fstest.go:247: Filtering empty directory "d"
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (12.40s)
=== RUN   TestSyncDeleteAfter
--- PASS: TestSyncDeleteAfter (0.00s)
=== RUN   TestSyncDeleteDuring
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:25:14 DEBUG : potato: md5 = bcd4dd7c9b73a7c6d31266f6d13f4067 OK
2025/06/27 07:25:19 DEBUG : empty space: md5 = afae6948f60bc7bc338801b5a0ab1ec9 OK
2025/06/27 07:25:29 DEBUG : Waiting for deletions to finish
2025/06/27 07:25:29 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:25:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:25:30 DEBUG : potato2: md5 = 6a76f83155fac72a6126de828dae7a9c OK
2025/06/27 07:25:30 INFO  : potato2: Copied (new)
2025/06/27 07:25:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:25:35 DEBUG : empty space: Unchanged skipping
2025/06/27 07:25:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:25:40 INFO  : potato: Deleted
--- PASS: TestSyncDeleteDuring (41.69s)
=== RUN   TestSyncDeleteBefore
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:25:56 DEBUG : potato: md5 = ecba3db22198b12e2cc1147fcd419cbf OK
2025/06/27 07:26:01 DEBUG : empty space: md5 = f36d2cc10386ddecfc1bdf85df96c6dc OK
2025/06/27 07:26:06 DEBUG : Waiting for deletions to finish
2025/06/27 07:26:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:26:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:26:11 INFO  : potato: Deleted
2025/06/27 07:26:11 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:26:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:26:11 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:26:11 DEBUG : empty space: Unchanged skipping
2025/06/27 07:26:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:26:12 DEBUG : potato2: md5 = 7f55bdebea9101f716120af85b1d9dc9 OK
2025/06/27 07:26:12 INFO  : potato2: Copied (new)
--- PASS: TestSyncDeleteBefore (37.17s)
=== RUN   TestCopyDeleteBefore
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:26:33 DEBUG : potato: md5 = 9805a4bc71c2908ed5f964d6cc4e117b OK
2025/06/27 07:26:38 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:26:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:26:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:26:38 DEBUG : potato2: md5 = 8057a70cff7cd8bf7edc5e116cbb9298 OK
2025/06/27 07:26:38 INFO  : potato2: Copied (new)
--- PASS: TestCopyDeleteBefore (21.44s)
=== RUN   TestSyncWithExclude
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:26:49 DEBUG : potato2: md5 = c4342bc3211811d507416941e8d5c1e2 OK
2025/06/27 07:26:55 DEBUG : empty space: md5 = 5048264eaa792c4463fd2f1d4937a24f OK
2025/06/27 07:26:55 DEBUG : enormous: Excluded (Size Filter)
2025/06/27 07:26:55 DEBUG : enormous: Excluded
2025/06/27 07:26:55 DEBUG : potato2: Excluded (Size Filter)
2025/06/27 07:26:55 DEBUG : potato2: Excluded
2025/06/27 07:26:55 DEBUG : potato2: Excluded (Size Filter)
2025/06/27 07:26:55 DEBUG : potato2: Excluded
2025/06/27 07:26:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:27:00 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:27:00 DEBUG : empty space: Unchanged skipping
2025/06/27 07:27:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:27:00 DEBUG : Waiting for deletions to finish
2025/06/27 07:27:00 INFO  : There was nothing to transfer
2025/06/27 07:27:05 DEBUG : enormous: Excluded (Size Filter)
2025/06/27 07:27:05 DEBUG : enormous: Excluded
2025/06/27 07:27:05 DEBUG : potato2: Excluded (Size Filter)
2025/06/27 07:27:05 DEBUG : potato2: Excluded
2025/06/27 07:27:05 DEBUG : potato2: Excluded (Size Filter)
2025/06/27 07:27:05 DEBUG : potato2: Excluded
2025/06/27 07:27:05 DEBUG : Local file system at /tmp/rclone1507986760: Waiting for checks to finish
2025/06/27 07:27:05 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:27:05 DEBUG : empty space: Unchanged skipping
2025/06/27 07:27:05 DEBUG : Local file system at /tmp/rclone1507986760: Waiting for transfers to finish
2025/06/27 07:27:05 DEBUG : Waiting for deletions to finish
2025/06/27 07:27:05 INFO  : There was nothing to transfer
--- PASS: TestSyncWithExclude (21.64s)
=== RUN   TestSyncWithExcludeAndDeleteExcluded
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:27:11 DEBUG : potato2: md5 = b098831acc637dd7f9454b30a910ac3c OK
2025/06/27 07:27:16 DEBUG : empty space: md5 = 29708768ad45b9be7b5be9558fbd2d43 OK
2025/06/27 07:27:22 DEBUG : enormous: md5 = 4d7fe92f798c463f63fbeebff5bf568d OK
2025/06/27 07:27:27 DEBUG : enormous: Excluded (Size Filter)
2025/06/27 07:27:27 DEBUG : enormous: Excluded
2025/06/27 07:27:27 DEBUG : potato2: Excluded (Size Filter)
2025/06/27 07:27:27 DEBUG : potato2: Excluded
2025/06/27 07:27:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:27:27 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:27:27 DEBUG : empty space: Unchanged skipping
2025/06/27 07:27:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:27:27 DEBUG : Waiting for deletions to finish
2025/06/27 07:27:27 INFO  : potato2: Deleted
2025/06/27 07:27:32 INFO  : enormous: Deleted
2025/06/27 07:27:32 INFO  : There was nothing to transfer
2025/06/27 07:27:33 DEBUG : Local file system at /tmp/rclone1507986760: Waiting for checks to finish
2025/06/27 07:27:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:27:33 DEBUG : empty space: Unchanged skipping
2025/06/27 07:27:33 DEBUG : Local file system at /tmp/rclone1507986760: Waiting for transfers to finish
2025/06/27 07:27:33 DEBUG : Waiting for deletions to finish
2025/06/27 07:27:33 INFO  : enormous: Deleted
2025/06/27 07:27:33 INFO  : potato2: Deleted
2025/06/27 07:27:33 INFO  : There was nothing to transfer
--- PASS: TestSyncWithExcludeAndDeleteExcluded (32.32s)
=== RUN   TestSyncWithUpdateOlder
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:27:48 DEBUG : one: md5 = ad35179f5bf36f01ce94f0932c8555b5 OK
2025/06/27 07:27:49 DEBUG : two: md5 = 173914f3dc575ca72767bb6743b738d9 OK
2025/06/27 07:27:49 DEBUG : three: md5 = 8aaff24e71417a2b04a8e3bc8ae30d20 OK
2025/06/27 07:27:55 DEBUG : four: md5 = 2d522cb463ef13fba9fefeaaee46234c OK
2025/06/27 07:27:55 DEBUG : five: Need to transfer - File not found at Destination
2025/06/27 07:27:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:27:55 DEBUG : four: Sizes differ (src 4 vs dst 8)
2025/06/27 07:27:55 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring
2025/06/27 07:27:55 DEBUG : one: Destination is newer than source, skipping
2025/06/27 07:27:55 DEBUG : three: Sizes identical
2025/06/27 07:27:55 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping
2025/06/27 07:27:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:27:56 DEBUG : two: md5 = e976602e65557f5efc4a3447a1899526 OK
2025/06/27 07:27:56 INFO  : two: Copied (replaced existing)
2025/06/27 07:27:57 DEBUG : five: md5 = c0b19c741135a04451905bba404bda3c OK
2025/06/27 07:27:57 INFO  : five: Copied (new)
2025/06/27 07:28:00 DEBUG : four: md5 = 1052e3a0fda3a5feebc23c8ff1685c45 OK
2025/06/27 07:28:00 INFO  : four: Copied (replaced existing)
2025/06/27 07:28:00 DEBUG : Waiting for deletions to finish
    sync_test.go:1450: Skip test with --checksum as no hashes supported
--- PASS: TestSyncWithUpdateOlder (29.43s)
=== RUN   TestSyncWithMaxDuration
=== RUN   TestSyncWithMaxDuration/Hard
    sync_test.go:1467: Skipping test on non local remote
=== RUN   TestSyncWithMaxDuration/Soft
    sync_test.go:1467: Skipping test on non local remote
--- PASS: TestSyncWithMaxDuration (0.00s)
    --- SKIP: TestSyncWithMaxDuration/Hard (0.00s)
    --- SKIP: TestSyncWithMaxDuration/Soft (0.00s)
=== RUN   TestSyncWithTrackRenames
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:1539: Can track renames: false
2025/06/27 07:28:13 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Ignoring --track-renames as the source and destination do not have a common hash
2025/06/27 07:28:13 DEBUG : potato: Need to transfer - File not found at Destination
2025/06/27 07:28:13 DEBUG : yam: Need to transfer - File not found at Destination
2025/06/27 07:28:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:28:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:28:18 DEBUG : potato: md5 = 963fe948d3da8522085e2376e24eb167 OK
2025/06/27 07:28:18 INFO  : potato: Copied (new)
2025/06/27 07:28:18 DEBUG : yam: md5 = 26a74967dd84e3d43508bb138503dae5 OK
2025/06/27 07:28:18 INFO  : yam: Copied (new)
2025/06/27 07:28:18 DEBUG : Waiting for deletions to finish
2025/06/27 07:28:28 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Ignoring --track-renames as the source and destination do not have a common hash
2025/06/27 07:28:28 DEBUG : yaml: Need to transfer - File not found at Destination
2025/06/27 07:28:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:28:29 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:28:29 DEBUG : potato: Unchanged skipping
2025/06/27 07:28:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:28:34 DEBUG : yaml: md5 = fe818c03d0f12806309fc7dcf479ed76 OK
2025/06/27 07:28:34 INFO  : yaml: Copied (new)
2025/06/27 07:28:34 DEBUG : Waiting for deletions to finish
2025/06/27 07:28:39 INFO  : yam: Deleted
--- PASS: TestSyncWithTrackRenames (46.78s)
=== RUN   TestParseRenamesStrategyModtime
--- PASS: TestParseRenamesStrategyModtime (0.00s)
=== RUN   TestRenamesStrategyModtime
--- PASS: TestRenamesStrategyModtime (0.00s)
=== RUN   TestSyncWithTrackRenamesStrategyModtime
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:1611: Can track renames: true
2025/06/27 07:29:00 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Making map for --track-renames
2025/06/27 07:29:00 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Finished making map for --track-renames
2025/06/27 07:29:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:29:00 DEBUG : potato: Need to transfer - No matching file found at Destination
2025/06/27 07:29:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for renames to finish
2025/06/27 07:29:00 DEBUG : yam: Need to transfer - No matching file found at Destination
2025/06/27 07:29:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:29:05 DEBUG : yam: md5 = 745bd7beece02bd45ad25370a00deb87 OK
2025/06/27 07:29:05 INFO  : yam: Copied (new)
2025/06/27 07:29:05 DEBUG : potato: md5 = 717e0358786cd0421409593c46c27f0d OK
2025/06/27 07:29:05 INFO  : potato: Copied (new)
2025/06/27 07:29:05 DEBUG : Waiting for deletions to finish
2025/06/27 07:29:05 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Making map for --track-renames
2025/06/27 07:29:05 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Finished making map for --track-renames
2025/06/27 07:29:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:29:05 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:29:05 DEBUG : potato: Unchanged skipping
2025/06/27 07:29:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for renames to finish
2025/06/27 07:29:31 INFO  : yam: Copied (server-side copy) to: yaml
2025/06/27 07:29:36 INFO  : yam: Deleted
2025/06/27 07:29:36 INFO  : yaml: Renamed from "yam"
2025/06/27 07:29:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:29:36 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithTrackRenamesStrategyModtime (51.83s)
=== RUN   TestSyncWithTrackRenamesStrategyLeaf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:1650: Can track renames: true
2025/06/27 07:29:51 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Making map for --track-renames
2025/06/27 07:29:51 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Finished making map for --track-renames
2025/06/27 07:29:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:29:51 DEBUG : potato: Need to transfer - No matching file found at Destination
2025/06/27 07:29:51 DEBUG : sub/yam: Need to transfer - No matching file found at Destination
2025/06/27 07:29:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for renames to finish
2025/06/27 07:29:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:29:56 DEBUG : potato: md5 = a71593c5c7b07efd507b0a93570dc4f8 OK
2025/06/27 07:29:56 INFO  : potato: Copied (new)
2025/06/27 07:29:57 DEBUG : sub/yam: md5 = 10a7af668d44aa4a83a1fc53ebb45e52 OK
2025/06/27 07:29:57 INFO  : sub/yam: Copied (new)
2025/06/27 07:29:57 DEBUG : Waiting for deletions to finish
2025/06/27 07:29:57 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:29:57 DEBUG : potato: Unchanged skipping
2025/06/27 07:29:57 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Making map for --track-renames
2025/06/27 07:29:57 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Finished making map for --track-renames
2025/06/27 07:29:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:29:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for renames to finish
2025/06/27 07:30:13 INFO  : sub/yam: Copied (server-side copy) to: yam
2025/06/27 07:30:18 INFO  : sub/yam: Deleted
2025/06/27 07:30:18 INFO  : yam: Renamed from "sub/yam"
2025/06/27 07:30:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:30:18 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithTrackRenamesStrategyLeaf (36.91s)
=== RUN   TestServerSideMoveLocal
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:30:28 DEBUG : Creating backend with remote "/tmp/rclone1507986760/dir1"
2025/06/27 07:30:28 DEBUG : Creating backend with remote "/tmp/rclone1507986760/dir2"
2025/06/27 07:30:28 DEBUG : Local file system at /tmp/rclone1507986760/dir2: Using server-side directory move
2025/06/27 07:30:28 INFO  : Local file system at /tmp/rclone1507986760/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/06/27 07:30:28 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/06/27 07:30:28 DEBUG : Local file system at /tmp/rclone1507986760/dir2: Waiting for checks to finish
2025/06/27 07:30:28 INFO  : file1.txt: Moved (server-side)
2025/06/27 07:30:28 DEBUG : Local file system at /tmp/rclone1507986760/dir2: Waiting for transfers to finish
--- PASS: TestServerSideMoveLocal (0.39s)
=== RUN   TestMoveWithDeleteEmptySrcDirs
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:30:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:30:29 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination
2025/06/27 07:30:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:30:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:30:29 DEBUG : nested/sub dir/file: md5 = 4a279a389960f69733eccef0889ce5f5 OK
2025/06/27 07:30:29 INFO  : nested/sub dir/file: Copied (new)
2025/06/27 07:30:29 INFO  : nested/sub dir/file: Deleted
2025/06/27 07:30:34 DEBUG : sub dir/hello world: md5 = 65426d614817fc04a32d001c21206732 OK
2025/06/27 07:30:34 INFO  : sub dir/hello world: Copied (new)
2025/06/27 07:30:34 INFO  : sub dir/hello world: Deleted
2025/06/27 07:30:34 INFO  : sub dir: Removing directory
2025/06/27 07:30:34 INFO  : nested/sub dir: Removing directory
2025/06/27 07:30:34 INFO  : nested: Removing directory
2025/06/27 07:30:34 DEBUG : Local file system at /tmp/rclone1507986760: deleted 3 directories
--- PASS: TestMoveWithDeleteEmptySrcDirs (20.84s)
=== RUN   TestMoveWithoutDeleteEmptySrcDirs
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:30:50 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/27 07:30:50 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination
2025/06/27 07:30:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:30:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:30:50 DEBUG : nested/sub dir/file: md5 = 392fa0c017f4b896e8c975e4cd2a80e2 OK
2025/06/27 07:30:50 INFO  : nested/sub dir/file: Copied (new)
2025/06/27 07:30:50 INFO  : nested/sub dir/file: Deleted
2025/06/27 07:30:55 DEBUG : sub dir/hello world: md5 = 657424b3cc625fa96186c6a8a5a707ac OK
2025/06/27 07:30:55 INFO  : sub dir/hello world: Copied (new)
2025/06/27 07:30:55 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveWithoutDeleteEmptySrcDirs (15.84s)
=== RUN   TestMoveWithIgnoreExisting
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:31:05 DEBUG : existing-b: Need to transfer - File not found at Destination
2025/06/27 07:31:05 DEBUG : existing: Need to transfer - File not found at Destination
2025/06/27 07:31:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:31:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:31:10 DEBUG : existing: md5 = d4f61d33d4fe57b31ab51d5f28b64123 OK
2025/06/27 07:31:10 INFO  : existing: Copied (new)
2025/06/27 07:31:10 INFO  : existing: Deleted
2025/06/27 07:31:11 DEBUG : existing-b: md5 = 9dbd520bd8ab4507d6bbe88a15cc50d1 OK
2025/06/27 07:31:11 INFO  : existing-b: Copied (new)
2025/06/27 07:31:11 INFO  : existing-b: Deleted
2025/06/27 07:31:11 DEBUG : existing: Destination exists, skipping
2025/06/27 07:31:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:31:11 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set
2025/06/27 07:31:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:31:11 INFO  : There was nothing to transfer
--- PASS: TestMoveWithIgnoreExisting (26.93s)
=== RUN   TestServerSideMove
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:31:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kimimuv1fona"
2025/06/27 07:31:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kimimuv1fona.bin"
2025/06/27 07:31:33 DEBUG : Swift container crypt path rclone-test-kimimuv1fona.bin: Auto set use_segments_container to true
2025/06/27 07:31:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kimimuv1fona"
2025/06/27 07:31:38 DEBUG : Swift container crypt path rclone-test-kimimuv1fona: Auto set use_segments_container to true
2025/06/27 07:31:44 DEBUG : potato2: md5 = e9de60cf4c81a5bee4ef231194ccb7c5 OK
2025/06/27 07:31:49 DEBUG : empty space: md5 = b470d1cefec373e7d78652f8e9fb8dde OK
2025/06/27 07:31:55 DEBUG : potato3: md5 = 5038116482dd34389517c41dc9b4aa0b OK
    sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha' -> Encrypted drive 'TestCryptSwift:rclone-test-kimimuv1fona'
2025/06/27 07:32:06 DEBUG : empty space: md5 = 6cb549d878a419e14cc18307ba4c6ff6 OK
2025/06/27 07:32:11 DEBUG : potato3: md5 = 0c58bfe73322b6dac417044c7e0f7c5b OK
2025/06/27 07:32:16 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:32:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kimimuv1fona': Waiting for checks to finish
2025/06/27 07:32:16 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2025/06/27 07:32:22 INFO  : potato2: Copied (server-side copy)
2025/06/27 07:32:22 INFO  : potato2: Deleted
2025/06/27 07:32:27 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:32:27 DEBUG : empty space: Unchanged skipping
2025/06/27 07:32:27 INFO  : potato3: Copied (server-side copy)
2025/06/27 07:32:32 INFO  : empty space: Deleted
2025/06/27 07:32:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kimimuv1fona': Waiting for transfers to finish
2025/06/27 07:32:32 INFO  : potato3: Deleted
2025/06/27 07:32:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-fojewev6yoki"
2025/06/27 07:32:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fojewev6yoki.bin"
2025/06/27 07:32:33 DEBUG : Swift container crypt path rclone-test-fojewev6yoki.bin: Auto set use_segments_container to true
2025/06/27 07:32:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fojewev6yoki"
2025/06/27 07:32:38 DEBUG : Swift container crypt path rclone-test-fojewev6yoki: Auto set use_segments_container to true
2025/06/27 07:32:44 DEBUG : empty space: Need to transfer - File not found at Destination
2025/06/27 07:32:44 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:32:44 DEBUG : potato3: Need to transfer - File not found at Destination
2025/06/27 07:32:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fojewev6yoki': Waiting for checks to finish
2025/06/27 07:32:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fojewev6yoki': Waiting for transfers to finish
2025/06/27 07:32:50 INFO  : empty space: Copied (server-side copy)
2025/06/27 07:32:54 INFO  : potato3: Copied (server-side copy)
2025/06/27 07:32:54 INFO  : potato2: Copied (server-side copy)
2025/06/27 07:32:55 INFO  : potato2: Deleted
2025/06/27 07:32:55 INFO  : empty space: Deleted
2025/06/27 07:32:59 INFO  : potato3: Deleted
2025/06/27 07:33:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fojewev6yoki': Purge remote
2025/06/27 07:33:05 DEBUG : Waiting for deletions to finish
2025/06/27 07:33:05 INFO  : empty space.bin: Deleted
2025/06/27 07:33:10 INFO  : potato3.bin: Deleted
2025/06/27 07:33:10 INFO  : potato2.bin: Deleted
2025/06/27 07:33:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kimimuv1fona': Purge remote
2025/06/27 07:33:10 DEBUG : Waiting for deletions to finish
--- PASS: TestServerSideMove (98.19s)
=== RUN   TestServerSideMoveWithFilter
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:33:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xiqotor5fola"
2025/06/27 07:33:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xiqotor5fola.bin"
2025/06/27 07:33:11 DEBUG : Swift container crypt path rclone-test-xiqotor5fola.bin: Auto set use_segments_container to true
2025/06/27 07:33:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xiqotor5fola"
2025/06/27 07:33:16 DEBUG : Swift container crypt path rclone-test-xiqotor5fola: Auto set use_segments_container to true
2025/06/27 07:33:22 DEBUG : potato2: md5 = 9a8537ffa6b066f1b5cf3130ef672487 OK
2025/06/27 07:33:27 DEBUG : empty space: md5 = 1ae21eb489c032df2183287f316e5320 OK
2025/06/27 07:33:32 DEBUG : potato3: md5 = 9790105bbf288903a952f6a3af4fe373 OK
    sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha' -> Encrypted drive 'TestCryptSwift:rclone-test-xiqotor5fola'
2025/06/27 07:33:33 DEBUG : empty space: md5 = 33d28a364019a8a3cf85f743907d38ad OK
2025/06/27 07:33:33 DEBUG : potato3: md5 = d8ef69e49e37ca67108d4059d9a89f2e OK
2025/06/27 07:33:34 DEBUG : empty space: Excluded (Size Filter)
2025/06/27 07:33:34 DEBUG : empty space: Excluded
2025/06/27 07:33:34 DEBUG : empty space: Excluded (Size Filter)
2025/06/27 07:33:34 DEBUG : empty space: Excluded
2025/06/27 07:33:34 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:33:34 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2025/06/27 07:33:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xiqotor5fola': Waiting for checks to finish
2025/06/27 07:33:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xiqotor5fola': Waiting for transfers to finish
2025/06/27 07:33:39 INFO  : potato3: Copied (server-side copy)
2025/06/27 07:33:45 INFO  : potato3: Deleted
2025/06/27 07:33:47 INFO  : potato2: Copied (server-side copy)
2025/06/27 07:33:47 INFO  : potato2: Deleted
2025/06/27 07:33:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-sunubaw6fedo"
2025/06/27 07:33:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sunubaw6fedo.bin"
2025/06/27 07:33:48 DEBUG : Swift container crypt path rclone-test-sunubaw6fedo.bin: Auto set use_segments_container to true
2025/06/27 07:33:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sunubaw6fedo"
2025/06/27 07:33:54 DEBUG : Swift container crypt path rclone-test-sunubaw6fedo: Auto set use_segments_container to true
2025/06/27 07:33:59 DEBUG : empty space: Excluded (Size Filter)
2025/06/27 07:33:59 DEBUG : empty space: Excluded
2025/06/27 07:33:59 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:33:59 DEBUG : potato3: Need to transfer - File not found at Destination
2025/06/27 07:33:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sunubaw6fedo': Waiting for checks to finish
2025/06/27 07:33:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sunubaw6fedo': Waiting for transfers to finish
2025/06/27 07:34:05 INFO  : potato3: Copied (server-side copy)
2025/06/27 07:34:05 INFO  : potato3: Deleted
2025/06/27 07:34:10 INFO  : potato2: Copied (server-side copy)
2025/06/27 07:34:15 INFO  : potato2: Deleted
2025/06/27 07:34:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sunubaw6fedo': Purge remote
2025/06/27 07:34:15 DEBUG : Waiting for deletions to finish
2025/06/27 07:34:15 INFO  : potato2.bin: Deleted
2025/06/27 07:34:15 INFO  : potato3.bin: Deleted
2025/06/27 07:34:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xiqotor5fola': Purge remote
2025/06/27 07:34:15 DEBUG : Waiting for deletions to finish
2025/06/27 07:34:16 INFO  : empty space.bin: Deleted
--- PASS: TestServerSideMoveWithFilter (70.76s)
=== RUN   TestServerSideMoveDeleteEmptySourceDirs
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:34:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gamebon6paso"
2025/06/27 07:34:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gamebon6paso.bin"
2025/06/27 07:34:21 DEBUG : Swift container crypt path rclone-test-gamebon6paso.bin: Auto set use_segments_container to true
2025/06/27 07:34:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gamebon6paso"
2025/06/27 07:34:27 DEBUG : Swift container crypt path rclone-test-gamebon6paso: Auto set use_segments_container to true
2025/06/27 07:34:33 DEBUG : potato2: md5 = aae3048a631a5b2c2de514fd41503cd2 OK
2025/06/27 07:34:38 DEBUG : empty space: md5 = 92096db57830e79b6c424d7472e3a396 OK
2025/06/27 07:34:43 DEBUG : potato3: md5 = 2bfe695559a812c3138caeea43e4ee13 OK
2025/06/27 07:34:43 INFO  : tomatoDir: Making directory
    sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha' -> Encrypted drive 'TestCryptSwift:rclone-test-gamebon6paso'
2025/06/27 07:34:54 DEBUG : empty space: md5 = 4d66c85cd58224fe401a00c9274026e9 OK
2025/06/27 07:34:59 DEBUG : potato3: md5 = 2b70e9f3c53ea096fc7f84cf5803841b OK
2025/06/27 07:35:05 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:35:05 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2025/06/27 07:35:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gamebon6paso': Waiting for checks to finish
2025/06/27 07:35:10 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:35:10 DEBUG : empty space: Unchanged skipping
2025/06/27 07:35:15 INFO  : empty space: Deleted
2025/06/27 07:35:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gamebon6paso': Waiting for transfers to finish
2025/06/27 07:35:15 INFO  : potato2: Copied (server-side copy)
2025/06/27 07:35:15 INFO  : potato2: Deleted
2025/06/27 07:35:16 INFO  : potato3: Copied (server-side copy)
2025/06/27 07:35:21 INFO  : potato3: Deleted
2025/06/27 07:35:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-pujovok3sibo"
2025/06/27 07:35:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pujovok3sibo.bin"
2025/06/27 07:35:27 DEBUG : Swift container crypt path rclone-test-pujovok3sibo.bin: Auto set use_segments_container to true
2025/06/27 07:35:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pujovok3sibo"
2025/06/27 07:35:32 DEBUG : Swift container crypt path rclone-test-pujovok3sibo: Auto set use_segments_container to true
2025/06/27 07:35:37 INFO  : tomatoDir: Making directory
2025/06/27 07:35:38 DEBUG : empty space: Need to transfer - File not found at Destination
2025/06/27 07:35:38 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/27 07:35:38 DEBUG : potato3: Need to transfer - File not found at Destination
2025/06/27 07:35:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pujovok3sibo': Waiting for checks to finish
2025/06/27 07:35:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pujovok3sibo': Waiting for transfers to finish
2025/06/27 07:35:43 INFO  : potato2: Copied (server-side copy)
2025/06/27 07:35:44 INFO  : potato3: Copied (server-side copy)
2025/06/27 07:35:48 INFO  : empty space: Copied (server-side copy)
2025/06/27 07:35:48 INFO  : potato2: Deleted
2025/06/27 07:35:49 INFO  : potato3: Deleted
2025/06/27 07:35:53 INFO  : empty space: Deleted
2025/06/27 07:35:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pujovok3sibo': Purge remote
2025/06/27 07:35:54 DEBUG : Waiting for deletions to finish
2025/06/27 07:35:54 INFO  : potato3.bin: Deleted
2025/06/27 07:35:54 INFO  : potato2.bin: Deleted
2025/06/27 07:35:59 INFO  : empty space.bin: Deleted
2025/06/27 07:35:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gamebon6paso': Purge remote
2025/06/27 07:35:59 DEBUG : Waiting for deletions to finish
--- PASS: TestServerSideMoveDeleteEmptySourceDirs (98.05s)
=== RUN   TestServerSideMoveOverlap
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:35:59 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/rclone-move-test"
2025/06/27 07:35:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-move-test.bin"
2025/06/27 07:36:00 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-move-test.bin: Auto set use_segments_container to true
2025/06/27 07:36:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-move-test"
2025/06/27 07:36:05 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-move-test: Auto set use_segments_container to true
2025/06/27 07:36:11 DEBUG : potato2: md5 = 9bc1c7a6e6bb7c274c2e1502172c45e3 OK
--- PASS: TestServerSideMoveOverlap (12.03s)
=== RUN   TestSyncOverlap
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:36:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test"
2025/06/27 07:36:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-sync-test.bin"
2025/06/27 07:36:12 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-sync-test.bin: Auto set use_segments_container to true
2025/06/27 07:36:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-sync-test"
2025/06/27 07:36:17 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-sync-test: Auto set use_segments_container to true
--- PASS: TestSyncOverlap (11.65s)
=== RUN   TestSyncOverlapWithFilter
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:36:23 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test"
2025/06/27 07:36:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-sync-test.bin"
2025/06/27 07:36:23 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-sync-test.bin: Auto set use_segments_container to true
2025/06/27 07:36:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-sync-test"
2025/06/27 07:36:29 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-sync-test: Auto set use_segments_container to true
2025/06/27 07:36:34 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test-include/layer2"
2025/06/27 07:36:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-sync-test-include/layer2.bin"
2025/06/27 07:36:34 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true
2025/06/27 07:36:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-sync-test-include/layer2"
2025/06/27 07:36:40 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-sync-test-include/layer2: Auto set use_segments_container to true
2025/06/27 07:36:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test-ignore-file"
2025/06/27 07:36:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-sync-test-ignore-file.bin"
2025/06/27 07:36:46 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true
2025/06/27 07:36:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/rclone-sync-test-ignore-file"
2025/06/27 07:36:51 DEBUG : Swift container crypt path rclone-test-wediner7qeha/rclone-sync-test-ignore-file: Auto set use_segments_container to true
2025/06/27 07:37:02 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = 1dca6e3597178b26cfe2c7ba004a7df1 OK
2025/06/27 07:37:12 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/27 07:37:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test': Waiting for checks to finish
2025/06/27 07:37:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test': Waiting for transfers to finish
2025/06/27 07:37:12 DEBUG : Waiting for deletions to finish
2025/06/27 07:37:12 INFO  : There was nothing to transfer
2025/06/27 07:37:17 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/27 07:37:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:37:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:37:17 DEBUG : Waiting for deletions to finish
2025/06/27 07:37:17 INFO  : There was nothing to transfer
2025/06/27 07:37:23 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/27 07:37:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test-include/layer2': Waiting for checks to finish
2025/06/27 07:37:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test-include/layer2': Waiting for transfers to finish
2025/06/27 07:37:23 DEBUG : Waiting for deletions to finish
2025/06/27 07:37:23 INFO  : There was nothing to transfer
2025/06/27 07:37:28 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/27 07:37:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 07:37:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 07:37:28 DEBUG : Waiting for deletions to finish
2025/06/27 07:37:28 INFO  : There was nothing to transfer
2025/06/27 07:37:33 DEBUG : Excluded
2025/06/27 07:37:38 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/27 07:37:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test-ignore-file': Waiting for checks to finish
2025/06/27 07:37:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/rclone-sync-test-ignore-file': Waiting for transfers to finish
2025/06/27 07:37:38 DEBUG : Waiting for deletions to finish
2025/06/27 07:37:38 INFO  : There was nothing to transfer
--- PASS: TestSyncOverlapWithFilter (85.38s)
=== RUN   TestSyncCompareDest
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:37:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/dst"
2025/06/27 07:37:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst.bin"
2025/06/27 07:37:49 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst.bin: Auto set use_segments_container to true
2025/06/27 07:37:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst"
2025/06/27 07:37:59 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst: Auto set use_segments_container to true
2025/06/27 07:38:05 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/CompareDest"
2025/06/27 07:38:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/CompareDest.bin"
2025/06/27 07:38:05 DEBUG : Swift container crypt path rclone-test-wediner7qeha/CompareDest.bin: Auto set use_segments_container to true
2025/06/27 07:38:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/CompareDest"
2025/06/27 07:38:10 DEBUG : Swift container crypt path rclone-test-wediner7qeha/CompareDest: Auto set use_segments_container to true
2025/06/27 07:38:21 DEBUG : one: Need to transfer - File not found at Destination
2025/06/27 07:38:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:38:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:38:26 DEBUG : one: md5 = 45b0a3811007150dbdd12eec3a95810e OK
2025/06/27 07:38:26 INFO  : one: Copied (new)
2025/06/27 07:38:26 DEBUG : Waiting for deletions to finish
2025/06/27 07:38:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:38:32 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/27 07:38:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:38:42 DEBUG : one: md5 = 618e56617654f4ea756d65387358a83f OK
2025/06/27 07:38:42 INFO  : one: Copied (replaced existing)
2025/06/27 07:38:42 DEBUG : Waiting for deletions to finish
2025/06/27 07:38:53 DEBUG : dst/one: md5 = 32fd53eea1eececfa22a3829c52de21d OK
2025/06/27 07:38:53 DEBUG : CompareDest/one: md5 = 7fa658cbbce62228efde22e4f154ff15 OK
2025/06/27 07:38:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:38:58 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/27 07:38:58 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:38:58 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/27 07:38:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:38:58 DEBUG : Waiting for deletions to finish
2025/06/27 07:38:58 INFO  : There was nothing to transfer
2025/06/27 07:39:04 DEBUG : CompareDest/two: md5 = 95d49ff77916efd0d37d98e59b243b11 OK
2025/06/27 07:39:09 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/27 07:39:09 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:39:09 DEBUG : two: Destination found in --compare-dest, skipping
2025/06/27 07:39:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:39:09 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:39:09 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/27 07:39:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:39:09 DEBUG : Waiting for deletions to finish
2025/06/27 07:39:09 INFO  : There was nothing to transfer
2025/06/27 07:39:15 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/27 07:39:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:39:15 DEBUG : two: Destination found in --compare-dest, skipping
2025/06/27 07:39:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:39:15 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:39:15 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/27 07:39:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:39:15 DEBUG : Waiting for deletions to finish
2025/06/27 07:39:15 INFO  : There was nothing to transfer
    sync_test.go:2176: No hash on uploaded file so skipping compare timestamp test
2025/06/27 07:39:20 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/27 07:39:20 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:39:20 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/27 07:39:20 DEBUG : two: Sizes differ (src 5 vs dst 3)
2025/06/27 07:39:20 DEBUG : two: Need to transfer - File not found at Destination
2025/06/27 07:39:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:39:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:39:21 DEBUG : two: md5 = 16280ffe2d21a27c4e29067cbca36761 OK
2025/06/27 07:39:21 INFO  : two: Copied (new)
2025/06/27 07:39:21 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCompareDest (108.44s)
=== RUN   TestSyncMultipleCompareDest
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:39:42 DEBUG : pre-dest1/1: md5 = de4f0512d8624aa0beafb10faaaf77d3 OK
2025/06/27 07:39:43 DEBUG : pre-dest2/2: md5 = 580f23994abe64764a50aed29c8042d5 OK
2025/06/27 07:39:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/dest"
2025/06/27 07:39:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dest.bin"
2025/06/27 07:39:43 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dest.bin: Auto set use_segments_container to true
2025/06/27 07:39:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dest"
2025/06/27 07:39:49 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dest: Auto set use_segments_container to true
2025/06/27 07:39:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/pre-dest1"
2025/06/27 07:39:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/pre-dest1.bin"
2025/06/27 07:39:55 DEBUG : Swift container crypt path rclone-test-wediner7qeha/pre-dest1.bin: Auto set use_segments_container to true
2025/06/27 07:40:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/pre-dest1"
2025/06/27 07:40:00 DEBUG : Swift container crypt path rclone-test-wediner7qeha/pre-dest1: Auto set use_segments_container to true
2025/06/27 07:40:06 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/pre-dest2"
2025/06/27 07:40:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/pre-dest2.bin"
2025/06/27 07:40:06 DEBUG : Swift container crypt path rclone-test-wediner7qeha/pre-dest2.bin: Auto set use_segments_container to true
2025/06/27 07:40:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/pre-dest2"
2025/06/27 07:40:11 DEBUG : Swift container crypt path rclone-test-wediner7qeha/pre-dest2: Auto set use_segments_container to true
2025/06/27 07:40:17 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:40:17 DEBUG : 1: Destination found in --compare-dest, skipping
2025/06/27 07:40:22 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:40:22 DEBUG : 2: Destination found in --compare-dest, skipping
2025/06/27 07:40:33 DEBUG : 3: Need to transfer - File not found at Destination
2025/06/27 07:40:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dest': Waiting for checks to finish
2025/06/27 07:40:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dest': Waiting for transfers to finish
2025/06/27 07:40:38 DEBUG : 3: md5 = d2bb9ab97f8d4b3fb66e86a9c0d72733 OK
2025/06/27 07:40:38 INFO  : 3: Copied (new)
2025/06/27 07:40:38 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncMultipleCompareDest (92.50s)
=== RUN   TestSyncCopyDest
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:41:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/dst"
2025/06/27 07:41:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst.bin"
2025/06/27 07:41:09 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst.bin: Auto set use_segments_container to true
2025/06/27 07:41:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst"
2025/06/27 07:41:20 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst: Auto set use_segments_container to true
2025/06/27 07:41:25 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/CopyDest"
2025/06/27 07:41:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/CopyDest.bin"
2025/06/27 07:41:26 DEBUG : Swift container crypt path rclone-test-wediner7qeha/CopyDest.bin: Auto set use_segments_container to true
2025/06/27 07:41:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/CopyDest"
2025/06/27 07:41:31 DEBUG : Swift container crypt path rclone-test-wediner7qeha/CopyDest: Auto set use_segments_container to true
2025/06/27 07:41:42 DEBUG : one: Need to transfer - File not found at Destination
2025/06/27 07:41:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:41:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:41:47 DEBUG : one: md5 = 57dc192db6061c3b4b9f1f67627c51f3 OK
2025/06/27 07:41:47 INFO  : one: Copied (new)
2025/06/27 07:41:47 DEBUG : Waiting for deletions to finish
2025/06/27 07:41:52 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/27 07:41:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:41:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:42:03 DEBUG : one: md5 = fef0e3f55c9947fd12604cd341f05af2 OK
2025/06/27 07:42:03 INFO  : one: Copied (replaced existing)
2025/06/27 07:42:03 DEBUG : Waiting for deletions to finish
2025/06/27 07:42:08 DEBUG : dst/one: md5 = 071a76e64b704a052a5d68598c68fc35 OK
2025/06/27 07:42:08 DEBUG : CopyDest/one: md5 = 89ea6695f6f3305ae7a7b89767f2e6de OK
2025/06/27 07:42:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/BackupDir"
2025/06/27 07:42:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/BackupDir.bin"
2025/06/27 07:42:14 DEBUG : Swift container crypt path rclone-test-wediner7qeha/BackupDir.bin: Auto set use_segments_container to true
2025/06/27 07:42:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/BackupDir"
2025/06/27 07:42:20 DEBUG : Swift container crypt path rclone-test-wediner7qeha/BackupDir: Auto set use_segments_container to true
2025/06/27 07:42:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:42:25 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/27 07:42:25 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:42:25 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/27 07:42:41 INFO  : one: Copied (server-side copy)
2025/06/27 07:42:46 INFO  : one: Deleted
2025/06/27 07:43:01 INFO  : one: Copied (server-side copy)
2025/06/27 07:43:01 DEBUG : one: Destination found in --copy-dest, using server-side copy
2025/06/27 07:43:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:43:01 DEBUG : Waiting for deletions to finish
2025/06/27 07:43:17 DEBUG : CopyDest/two: md5 = 088cf7d774e11d67c5f7c94fba7f2cef OK
2025/06/27 07:43:27 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:43:27 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:43:27 DEBUG : one: Unchanged skipping
2025/06/27 07:43:33 INFO  : two: Copied (server-side copy)
2025/06/27 07:43:33 DEBUG : two: Destination found in --copy-dest, using server-side copy
2025/06/27 07:43:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:43:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:43:33 DEBUG : Waiting for deletions to finish
2025/06/27 07:43:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:43:48 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:43:48 DEBUG : two: Unchanged skipping
2025/06/27 07:43:48 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:43:48 DEBUG : one: Unchanged skipping
2025/06/27 07:43:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:43:48 DEBUG : Waiting for deletions to finish
2025/06/27 07:43:48 INFO  : There was nothing to transfer
2025/06/27 07:43:59 DEBUG : CopyDest/three: md5 = 0fd8d799beb31877a9e3af1c636dced2 OK
2025/06/27 07:44:04 DEBUG : three: Sizes differ (src 7 vs dst 5)
2025/06/27 07:44:04 DEBUG : three: Destination not found in --copy-dest
2025/06/27 07:44:04 DEBUG : three: Need to transfer - File not found at Destination
2025/06/27 07:44:04 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:44:04 DEBUG : one: Unchanged skipping
2025/06/27 07:44:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:44:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:44:04 DEBUG : two: Unchanged skipping
2025/06/27 07:44:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:44:09 DEBUG : three: md5 = ab612e3426792375e8425616dcc71ca7 OK
2025/06/27 07:44:09 INFO  : three: Copied (new)
2025/06/27 07:44:09 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCopyDest (217.10s)
=== RUN   TestSyncBackupDir
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:44:54 DEBUG : dst/one: md5 = f33da4e885d8e39a8b0fa4cdf99a93b9 OK
2025/06/27 07:44:55 DEBUG : dst/two: md5 = e03033d19aeee75e1f89ea98dd131719 OK
2025/06/27 07:44:55 DEBUG : dst/three.txt: md5 = 84231cf745707220dd86bb9149baf172 OK
2025/06/27 07:45:00 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/dst"
2025/06/27 07:45:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst.bin"
2025/06/27 07:45:01 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst.bin: Auto set use_segments_container to true
2025/06/27 07:45:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst"
2025/06/27 07:45:11 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst: Auto set use_segments_container to true
2025/06/27 07:45:31 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/backup"
2025/06/27 07:45:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/backup.bin"
2025/06/27 07:45:32 DEBUG : Swift container crypt path rclone-test-wediner7qeha/backup.bin: Auto set use_segments_container to true
2025/06/27 07:45:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/backup"
2025/06/27 07:45:52 DEBUG : Swift container crypt path rclone-test-wediner7qeha/backup: Auto set use_segments_container to true
2025/06/27 07:45:58 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/27 07:45:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:45:58 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:45:58 DEBUG : two: Unchanged skipping
2025/06/27 07:46:29 INFO  : one: Copied (server-side copy)
2025/06/27 07:46:50 INFO  : one: Deleted
2025/06/27 07:46:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:46:55 DEBUG : one: md5 = df2c51e1f2625802b42f790390408a24 OK
2025/06/27 07:46:55 INFO  : one: Copied (new)
2025/06/27 07:46:55 DEBUG : Waiting for deletions to finish
2025/06/27 07:47:11 INFO  : three.txt: Copied (server-side copy)
2025/06/27 07:47:11 INFO  : three.txt: Deleted
2025/06/27 07:47:11 INFO  : three.txt: Moved into backup dir
2025/06/27 07:47:11 DEBUG : dst/three.txt: md5 = 859d6fab2eed4f1d04e1072e68ee8bf6 OK
2025/06/27 07:47:17 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/27 07:47:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:47:17 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:47:17 DEBUG : two: Unchanged skipping
2025/06/27 07:47:27 INFO  : one: Copied (server-side copy)
2025/06/27 07:47:32 INFO  : one: Deleted
2025/06/27 07:47:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:47:37 DEBUG : one: md5 = e5792dc3901795c62599bc03d96dc435 OK
2025/06/27 07:47:37 INFO  : one: Copied (new)
2025/06/27 07:47:37 DEBUG : Waiting for deletions to finish
2025/06/27 07:47:53 INFO  : three.txt: Copied (server-side copy)
2025/06/27 07:47:53 INFO  : three.txt: Deleted
2025/06/27 07:47:53 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDir (207.80s)
=== RUN   TestSyncBackupDirWithSuffix
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:48:19 DEBUG : dst/one: md5 = ab65488684c46b360f943f692573eda9 OK
2025/06/27 07:48:19 DEBUG : dst/two: md5 = 684a69076f339d291e5dbf7dc415b358 OK
2025/06/27 07:48:20 DEBUG : dst/three.txt: md5 = e2778230ef302e95e273f36851b350f2 OK
2025/06/27 07:48:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/dst"
2025/06/27 07:48:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst.bin"
2025/06/27 07:48:20 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst.bin: Auto set use_segments_container to true
2025/06/27 07:49:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst"
2025/06/27 07:49:01 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst: Auto set use_segments_container to true
2025/06/27 07:49:06 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/backup"
2025/06/27 07:49:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/backup.bin"
2025/06/27 07:49:06 DEBUG : Swift container crypt path rclone-test-wediner7qeha/backup.bin: Auto set use_segments_container to true
2025/06/27 07:49:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/backup"
2025/06/27 07:49:12 DEBUG : Swift container crypt path rclone-test-wediner7qeha/backup: Auto set use_segments_container to true
2025/06/27 07:49:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:49:18 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/27 07:49:18 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:49:18 DEBUG : two: Unchanged skipping
2025/06/27 07:49:39 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/27 07:49:44 INFO  : one: Deleted
2025/06/27 07:49:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:49:49 DEBUG : one: md5 = a10d0e5fcac3ac11ea5478afb1f99b44 OK
2025/06/27 07:49:49 INFO  : one: Copied (new)
2025/06/27 07:49:49 DEBUG : Waiting for deletions to finish
2025/06/27 07:50:10 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/27 07:50:10 INFO  : three.txt: Deleted
2025/06/27 07:50:10 INFO  : three.txt: Moved into backup dir
2025/06/27 07:50:21 DEBUG : dst/three.txt: md5 = c323c54a1e174d479dfef60ef61aeac5 OK
2025/06/27 07:50:26 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/27 07:50:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:50:26 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:50:26 DEBUG : two: Unchanged skipping
2025/06/27 07:50:46 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/27 07:50:51 INFO  : one: Deleted
2025/06/27 07:50:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:50:57 DEBUG : one: md5 = cd2baff0e0032409ab9d8a59b9386bc9 OK
2025/06/27 07:50:57 INFO  : one: Copied (new)
2025/06/27 07:50:57 DEBUG : Waiting for deletions to finish
2025/06/27 07:51:12 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/27 07:51:12 INFO  : three.txt: Deleted
2025/06/27 07:51:12 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffix (208.96s)
=== RUN   TestSyncBackupDirWithSuffixKeepExtension
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:51:48 DEBUG : dst/one: md5 = eba6770a409e113b5b33df34d0241508 OK
2025/06/27 07:51:48 DEBUG : dst/two: md5 = e7cbf8c61114f531f0dd61f17fb8dcbd OK
2025/06/27 07:51:48 DEBUG : dst/three.txt: md5 = 546b97f89e3fafeed2a58125a178a2af OK
2025/06/27 07:51:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/dst"
2025/06/27 07:51:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst.bin"
2025/06/27 07:51:54 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst.bin: Auto set use_segments_container to true
2025/06/27 07:52:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst"
2025/06/27 07:52:05 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst: Auto set use_segments_container to true
2025/06/27 07:52:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/backup"
2025/06/27 07:52:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/backup.bin"
2025/06/27 07:52:10 DEBUG : Swift container crypt path rclone-test-wediner7qeha/backup.bin: Auto set use_segments_container to true
2025/06/27 07:52:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/backup"
2025/06/27 07:52:31 DEBUG : Swift container crypt path rclone-test-wediner7qeha/backup: Auto set use_segments_container to true
2025/06/27 07:52:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:52:36 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/27 07:52:36 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:52:36 DEBUG : two: Unchanged skipping
2025/06/27 07:52:52 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2025/06/27 07:52:57 INFO  : one: Deleted
2025/06/27 07:52:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:53:02 DEBUG : one: md5 = 5b886cebc2563acbb9d5129b531bbfaf OK
2025/06/27 07:53:02 INFO  : one: Copied (new)
2025/06/27 07:53:02 DEBUG : Waiting for deletions to finish
2025/06/27 07:53:13 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2025/06/27 07:53:13 INFO  : three.txt: Deleted
2025/06/27 07:53:13 INFO  : three.txt: Moved into backup dir
2025/06/27 07:53:14 DEBUG : dst/three.txt: md5 = edd3756e8decf447700b376e6d8d729e OK
2025/06/27 07:53:15 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/27 07:53:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:53:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:53:15 DEBUG : two: Unchanged skipping
2025/06/27 07:53:35 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2025/06/27 07:53:41 INFO  : one: Deleted
2025/06/27 07:53:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:53:46 DEBUG : one: md5 = 84ed5c0ff9528e465c0a081a3bd34dc7 OK
2025/06/27 07:53:46 INFO  : one: Copied (new)
2025/06/27 07:53:46 DEBUG : Waiting for deletions to finish
2025/06/27 07:53:51 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2025/06/27 07:53:51 INFO  : three.txt: Deleted
2025/06/27 07:53:51 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffixKeepExtension (139.48s)
=== RUN   TestSyncBackupDirSuffixOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:54:08 DEBUG : dst/one: md5 = 894e1f7fc9a71fb089c5a2f5b487140a OK
2025/06/27 07:54:08 DEBUG : dst/two: md5 = 69936d6c9cc531bd019ca89c0d25fd97 OK
2025/06/27 07:54:08 DEBUG : dst/three.txt: md5 = a78843c6e2e5c490a65d9e3564c6e7d9 OK
2025/06/27 07:54:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/dst"
2025/06/27 07:54:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst.bin"
2025/06/27 07:54:14 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst.bin: Auto set use_segments_container to true
2025/06/27 07:54:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst"
2025/06/27 07:54:24 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst: Auto set use_segments_container to true
2025/06/27 07:54:30 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/27 07:54:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:54:30 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:54:30 DEBUG : two: Unchanged skipping
2025/06/27 07:54:50 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/27 07:54:55 INFO  : one: Deleted
2025/06/27 07:54:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:55:01 DEBUG : one: md5 = 3a273160d7e4e307e57210b346155890 OK
2025/06/27 07:55:01 INFO  : one: Copied (new)
2025/06/27 07:55:01 DEBUG : Waiting for deletions to finish
2025/06/27 07:55:26 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/27 07:55:26 INFO  : three.txt: Deleted
2025/06/27 07:55:26 INFO  : three.txt: Moved into backup dir
2025/06/27 07:55:42 DEBUG : dst/three.txt: md5 = 5af9728a57e4bb7522e90371fad67ea4 OK
2025/06/27 07:55:47 DEBUG : one.bak: Excluded (Path Filter)
2025/06/27 07:55:47 DEBUG : one.bak: Excluded
2025/06/27 07:55:47 DEBUG : three.txt.bak: Excluded (Path Filter)
2025/06/27 07:55:47 DEBUG : three.txt.bak: Excluded
2025/06/27 07:55:47 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/27 07:55:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for checks to finish
2025/06/27 07:55:47 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:55:47 DEBUG : two: Unchanged skipping
2025/06/27 07:55:58 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/27 07:56:03 INFO  : one: Deleted
2025/06/27 07:56:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha/dst': Waiting for transfers to finish
2025/06/27 07:56:08 DEBUG : one: md5 = f72ed921240412b60e35b6b6e721fb98 OK
2025/06/27 07:56:08 INFO  : one: Copied (new)
2025/06/27 07:56:08 DEBUG : Waiting for deletions to finish
2025/06/27 07:56:28 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/27 07:56:28 INFO  : three.txt: Deleted
2025/06/27 07:56:28 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirSuffixOnly (181.97s)
=== RUN   TestSyncSuffix
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 07:57:10 DEBUG : dst/one: md5 = f72cbfdc0bdba1b68decba7ec6a23df7 OK
2025/06/27 07:57:10 DEBUG : dst/two: md5 = 105900653d748df0fed9d81fd6e02ba8 OK
2025/06/27 07:57:10 DEBUG : dst/three.txt: md5 = 769c5b777c21d6b0c2469c770a06bfa1 OK
2025/06/27 07:57:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/dst"
2025/06/27 07:57:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst.bin"
2025/06/27 07:57:16 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst.bin: Auto set use_segments_container to true
2025/06/27 07:57:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst"
2025/06/27 07:57:26 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst: Auto set use_segments_container to true
2025/06/27 07:57:36 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/27 07:57:52 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/27 07:57:57 INFO  : one: Deleted
2025/06/27 07:58:02 DEBUG : one: md5 = 3a4950bf74baa439065f75e37a3bbb5e OK
2025/06/27 07:58:02 INFO  : one: Copied (new)
2025/06/27 07:58:02 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:58:02 DEBUG : two: Unchanged skipping
2025/06/27 07:58:02 DEBUG : three.txt: Sizes differ (src 6 vs dst 5)
2025/06/27 07:58:30 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/27 07:58:30 INFO  : three.txt: Deleted
2025/06/27 07:58:31 DEBUG : three.txt: md5 = 162b401ee9edf389e2fd7d4624fef1e1 OK
2025/06/27 07:58:31 INFO  : three.txt: Copied (new)
2025/06/27 07:58:46 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/27 07:58:57 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/27 07:59:02 INFO  : one: Deleted
2025/06/27 07:59:07 DEBUG : one: md5 = 4fd587f9d941a42722b3cfcab9515f19 OK
2025/06/27 07:59:07 INFO  : one: Copied (new)
2025/06/27 07:59:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 07:59:07 DEBUG : two: Unchanged skipping
2025/06/27 07:59:07 DEBUG : three.txt: Sizes differ (src 19 vs dst 6)
2025/06/27 07:59:27 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/27 07:59:28 INFO  : three.txt: Deleted
2025/06/27 07:59:28 DEBUG : three.txt: md5 = 0c0615f38000cf42a9021de065fdfbb5 OK
2025/06/27 07:59:28 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffix (175.48s)
=== RUN   TestSyncSuffixKeepExtension
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 08:00:05 DEBUG : dst/one: md5 = 8cf492f431f4feee8e54feaf7b445361 OK
2025/06/27 08:00:05 DEBUG : dst/two: md5 = 585466a96509bb5660ce28a0517b18eb OK
2025/06/27 08:00:05 DEBUG : dst/three.txt: md5 = 90386e78541d66aecbfb5cc1dda093f6 OK
2025/06/27 08:00:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wediner7qeha/dst"
2025/06/27 08:00:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst.bin"
2025/06/27 08:00:11 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst.bin: Auto set use_segments_container to true
2025/06/27 08:00:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wediner7qeha/dst"
2025/06/27 08:00:22 DEBUG : Swift container crypt path rclone-test-wediner7qeha/dst: Auto set use_segments_container to true
2025/06/27 08:00:27 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/27 08:00:37 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2025/06/27 08:00:42 INFO  : one: Deleted
2025/06/27 08:00:48 DEBUG : one: md5 = 611567106dec655e99763ce69b40f12c OK
2025/06/27 08:00:48 INFO  : one: Copied (new)
2025/06/27 08:00:48 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:00:48 DEBUG : two: Unchanged skipping
2025/06/27 08:00:48 DEBUG : three.txt: Sizes differ (src 6 vs dst 5)
2025/06/27 08:01:06 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2025/06/27 08:01:06 INFO  : three.txt: Deleted
2025/06/27 08:01:06 DEBUG : three.txt: md5 = a311c090ef1d0b44b307d62081eaa042 OK
2025/06/27 08:01:06 INFO  : three.txt: Copied (new)
2025/06/27 08:01:17 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/27 08:01:22 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2025/06/27 08:01:27 INFO  : one: Deleted
2025/06/27 08:01:33 DEBUG : one: md5 = c37cd1f11afb2d89d827c713d0261549 OK
2025/06/27 08:01:33 INFO  : one: Copied (new)
2025/06/27 08:01:33 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:01:33 DEBUG : two: Unchanged skipping
2025/06/27 08:01:33 DEBUG : three.txt: Sizes differ (src 19 vs dst 6)
2025/06/27 08:01:43 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2025/06/27 08:01:43 INFO  : three.txt: Deleted
2025/06/27 08:01:43 DEBUG : three.txt: md5 = c04630b7f06a5ba2e219b89b63cdcc88 OK
2025/06/27 08:01:43 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffixKeepExtension (119.85s)
=== RUN   TestSyncUTFNorm
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 08:02:00 DEBUG : Testêé: md5 = 4efd493af031e96b217be718282f3cd8 OK
2025/06/27 08:02:00 DEBUG : Testêé: Sizes differ (src 14 vs dst 18)
2025/06/27 08:02:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 08:02:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 08:02:01 DEBUG : Testêé: md5 = 61ae63b4ef8cf2dac45b62b4a9e2446b OK
2025/06/27 08:02:01 INFO  : Testêé: Copied (replaced existing) to: Testêé
2025/06/27 08:02:01 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncUTFNorm (1.49s)
=== RUN   TestSyncImmutable
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 08:02:01 DEBUG : existing: Need to transfer - File not found at Destination
2025/06/27 08:02:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 08:02:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 08:02:07 DEBUG : existing: md5 = 4493d4fdd3489d63582186348b108899 OK
2025/06/27 08:02:07 INFO  : existing: Copied (new)
2025/06/27 08:02:07 DEBUG : Waiting for deletions to finish
2025/06/27 08:02:08 DEBUG : existing: Sizes differ (src 8 vs dst 6)
2025/06/27 08:02:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 08:02:08 ERROR : existing: Source and destination exist but do not match: immutable file modified
2025/06/27 08:02:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 08:02:08 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': not deleting files as there were IO errors
2025/06/27 08:02:08 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': not deleting directories as there were IO errors
--- PASS: TestSyncImmutable (11.58s)
=== RUN   TestSyncIgnoreCase
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 08:02:18 DEBUG : EXISTING: md5 = 5ff520fd67d71e87819eed6367f47f2f OK
2025/06/27 08:02:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 08:02:24 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:02:24 DEBUG : existing: Unchanged skipping
2025/06/27 08:02:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 08:02:24 DEBUG : Waiting for deletions to finish
2025/06/27 08:02:24 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreCase (16.29s)
=== RUN   TestFixCase
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:2636: Skipping test as local or remote are case-sensitive
--- SKIP: TestFixCase (0.20s)
=== RUN   TestMaxTransfer
=== RUN   TestMaxTransfer/Hard
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:2675: This test only runs on local
=== RUN   TestMaxTransfer/Soft
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:2675: This test only runs on local
=== RUN   TestMaxTransfer/Cautious
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
    sync_test.go:2675: This test only runs on local
--- PASS: TestMaxTransfer (0.55s)
    --- SKIP: TestMaxTransfer/Hard (0.21s)
    --- SKIP: TestMaxTransfer/Soft (0.13s)
    --- SKIP: TestMaxTransfer/Cautious (0.20s)
=== RUN   TestSyncConcurrentDelete
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 08:02:35 DEBUG : both0: md5 = 49eb93c7b374e94919ceda3a4868c56e OK
2025/06/27 08:02:40 DEBUG : only0: md5 = b5e5a1da941bd219a3e4739a71af1189 OK
2025/06/27 08:02:49 DEBUG : both1: md5 = 106652aecb5947504d3db3563e2cdddf OK
2025/06/27 08:02:49 DEBUG : only1: md5 = daa01bc6ed00f291483c846ff1bc3a0b OK
2025/06/27 08:02:49 DEBUG : both2: md5 = 7c86ef26dfc3f20dd529fe777104cb7b OK
2025/06/27 08:02:55 DEBUG : only2: md5 = 87c66c0d6dc6736c325bac2f09437416 OK
2025/06/27 08:03:00 DEBUG : both3: md5 = a223622d4c948a95284debbc97a4c997 OK
2025/06/27 08:03:05 DEBUG : only3: md5 = 2988bc0bd806d4c0c71d5c63337d3b49 OK
2025/06/27 08:03:11 DEBUG : both4: md5 = 0da3290c74eb7f9b34e1880187376ec0 OK
2025/06/27 08:03:11 DEBUG : only4: md5 = 7b214b004ed41d03335058c9136ea898 OK
2025/06/27 08:03:17 DEBUG : both5: md5 = 068f1cb49253455da075a2707577f55b OK
2025/06/27 08:03:22 DEBUG : only5: md5 = ea6c45bc3c81956da34f3ffd32e23ca7 OK
2025/06/27 08:03:28 DEBUG : both6: md5 = 137810feafdfe3e110128198ebe8939e OK
2025/06/27 08:03:28 DEBUG : only6: md5 = 1d50412cf27f1abbf7e964619510c9a2 OK
2025/06/27 08:03:33 DEBUG : both7: md5 = 310adb0454c8392da08aa9f8eb0019ad OK
2025/06/27 08:03:34 DEBUG : only7: md5 = 44f3703a1c4ea1e5a94b58ec7eb90cfe OK
2025/06/27 08:03:34 DEBUG : both8: md5 = f1f1eba987f3fc3d6f3fa4c75e16404c OK
2025/06/27 08:03:35 DEBUG : only8: md5 = a7e48e4f90f416a6efb1a47b5efb9340 OK
2025/06/27 08:03:40 DEBUG : both9: md5 = 5c2d818130481f6203504d9ebe3a41d2 OK
2025/06/27 08:03:45 DEBUG : only9: md5 = cd97b99605afe6164d64fcf35be083f6 OK
2025/06/27 08:03:51 DEBUG : both10: md5 = 848d1a2c7c56620067f619614dc870ef OK
2025/06/27 08:03:51 DEBUG : only10: md5 = 4dcc3192eba9eb39fbcf2867c99ac20a OK
2025/06/27 08:03:56 DEBUG : both11: md5 = dcb9389f660e8445acee980a3865be2d OK
2025/06/27 08:03:57 DEBUG : only11: md5 = 760a299489ccf76bc497f02984a13864 OK
2025/06/27 08:04:02 DEBUG : both12: md5 = 0cf435e3ce1f1ad430c897a5da430a62 OK
2025/06/27 08:04:07 DEBUG : only12: md5 = 455d7a150869ba073cf2f719c066db35 OK
2025/06/27 08:04:08 DEBUG : both13: md5 = 26583bb705520c01c557b48ff6b2bf5a OK
2025/06/27 08:04:08 DEBUG : only13: md5 = 550ef35e853a48e901b86812d27bac84 OK
2025/06/27 08:04:08 DEBUG : both14: md5 = 40597efe3e2da224916ac9384354aef6 OK
2025/06/27 08:04:14 DEBUG : only14: md5 = 2217fa70e3bdd914a75efca809b6a62d OK
2025/06/27 08:04:19 DEBUG : both15: md5 = 056206c08d69e7bdaafa2cb18c790d96 OK
2025/06/27 08:04:19 DEBUG : only15: md5 = 66401564aabccb8c9d380ca01b08e4ef OK
2025/06/27 08:04:20 DEBUG : both16: md5 = e1a69505852142ce7b2b8d11174456f1 OK
2025/06/27 08:04:20 DEBUG : only16: md5 = 4d8135e97a6cd7b0fa39e5e1ea55c960 OK
2025/06/27 08:04:25 DEBUG : both17: md5 = b1a698a4b0cb2eca09d1986811f63bbe OK
2025/06/27 08:04:31 DEBUG : only17: md5 = 3c2243683c09f3ab7bb447e227991e57 OK
2025/06/27 08:04:36 DEBUG : both18: md5 = 77c681d11b71afa58aaf5bc77cd38875 OK
2025/06/27 08:04:41 DEBUG : only18: md5 = bf0d7b25c15e1992787f4fa4eec787bd OK
2025/06/27 08:04:42 DEBUG : both19: md5 = 1e2b94b1fb96fa48e8f46766895f0d01 OK
2025/06/27 08:04:47 DEBUG : only19: md5 = d724ef08228f458036426fec47370e9c OK
2025/06/27 08:05:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 08:05:42 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both0: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both13: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both11: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both14: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both15: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both16: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both18: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both19: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both1: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both2: Unchanged skipping
2025/06/27 08:05:42 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:42 DEBUG : both3: Unchanged skipping
2025/06/27 08:05:47 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:47 DEBUG : both10: Unchanged skipping
2025/06/27 08:05:47 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:47 DEBUG : both5: Unchanged skipping
2025/06/27 08:05:47 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:47 DEBUG : both6: Unchanged skipping
2025/06/27 08:05:47 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:47 DEBUG : both12: Unchanged skipping
2025/06/27 08:05:47 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:47 DEBUG : both8: Unchanged skipping
2025/06/27 08:05:47 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:47 DEBUG : both17: Unchanged skipping
2025/06/27 08:05:47 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:47 DEBUG : both9: Unchanged skipping
2025/06/27 08:05:47 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:47 DEBUG : both4: Unchanged skipping
2025/06/27 08:05:52 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:05:52 DEBUG : both7: Unchanged skipping
2025/06/27 08:05:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 08:05:52 DEBUG : Waiting for deletions to finish
2025/06/27 08:05:52 INFO  : only1: Deleted
2025/06/27 08:05:53 INFO  : only13: Deleted
2025/06/27 08:05:53 INFO  : only10: Deleted
2025/06/27 08:05:53 INFO  : only7: Deleted
2025/06/27 08:05:57 INFO  : only12: Deleted
2025/06/27 08:05:57 INFO  : only17: Deleted
2025/06/27 08:05:58 INFO  : only9: Deleted
2025/06/27 08:05:58 INFO  : only11: Deleted
2025/06/27 08:06:02 INFO  : only0: Deleted
2025/06/27 08:06:02 INFO  : only15: Deleted
2025/06/27 08:06:02 INFO  : only16: Deleted
2025/06/27 08:06:03 INFO  : only14: Deleted
2025/06/27 08:06:04 INFO  : only6: Deleted
2025/06/27 08:06:08 INFO  : only18: Deleted
2025/06/27 08:06:09 INFO  : only3: Deleted
2025/06/27 08:06:09 INFO  : only5: Deleted
2025/06/27 08:06:09 INFO  : only4: Deleted
2025/06/27 08:06:09 INFO  : only19: Deleted
2025/06/27 08:06:09 INFO  : only8: Deleted
2025/06/27 08:06:14 INFO  : only2: Deleted
2025/06/27 08:06:14 INFO  : There was nothing to transfer
--- PASS: TestSyncConcurrentDelete (358.51s)
=== RUN   TestSyncConcurrentTruncate
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha'", Local "Local file system at /tmp/rclone1507986760", Modify Window "1ns"
2025/06/27 08:08:34 DEBUG : both0: md5 = c088288ba61db764abad0b573c1fce57 OK
2025/06/27 08:08:39 DEBUG : only0: md5 = 58a6f58cdc949cfba154e78136ba0273 OK
2025/06/27 08:08:47 DEBUG : both1: md5 = 649e3bb9a3b6bae62540350abe8f541f OK
2025/06/27 08:08:47 DEBUG : only1: md5 = 83305d5224c814702c3e29acd0c82a1b OK
2025/06/27 08:08:47 DEBUG : both2: md5 = ce1a0ba7492fd0cc225385026299f29c OK
2025/06/27 08:08:52 DEBUG : only2: md5 = c49351e472bda7d1b2a70b3f11baaf3d OK
2025/06/27 08:08:58 DEBUG : both3: md5 = 08bcd4f939a1fe9e6f30ec3ea0162c79 OK
2025/06/27 08:09:03 DEBUG : only3: md5 = dbff62dae791fe4896770f5d8f4fdae7 OK
2025/06/27 08:09:09 DEBUG : both4: md5 = c5b41271c2a5bd2e67ada5135df860e3 OK
2025/06/27 08:09:09 DEBUG : only4: md5 = d000b9d87d91b326d6f004af71c5e3e7 OK
2025/06/27 08:09:14 DEBUG : both5: md5 = b6f0e68c66a0e0ac885cb74b93207450 OK
2025/06/27 08:09:19 DEBUG : only5: md5 = a88708c3dd74d5744b659349a38d7623 OK
2025/06/27 08:09:25 DEBUG : both6: md5 = 2db4095d2fa206d1def733d1717042b2 OK
2025/06/27 08:09:25 DEBUG : only6: md5 = 597196fa097131df3e640a85f75e2007 OK
2025/06/27 08:09:30 DEBUG : both7: md5 = c2902f8d9a8dfff9b05cf8cfd6593d49 OK
2025/06/27 08:09:30 DEBUG : only7: md5 = 7896328f36ac768bd29effc3f37664a1 OK
2025/06/27 08:09:30 DEBUG : both8: md5 = b37b4223c4781b2b7abdfbe4a87b23ed OK
2025/06/27 08:09:31 DEBUG : only8: md5 = d91979dca0178d73899d0b647c4d1368 OK
2025/06/27 08:09:36 DEBUG : both9: md5 = 096bd7132bba08e304d38fc315ab8758 OK
2025/06/27 08:09:41 DEBUG : only9: md5 = e5039a2a5bbd46264e64df62ca9309f3 OK
2025/06/27 08:09:46 DEBUG : both10: md5 = afc84c8f37d9d8a1dfc75630225d8427 OK
2025/06/27 08:09:46 DEBUG : only10: md5 = 406aa1be790248f01aafbb4677c95151 OK
2025/06/27 08:09:51 DEBUG : both11: md5 = 89ab445033b9aced2f06fcdefac4e991 OK
2025/06/27 08:09:51 DEBUG : only11: md5 = 541c343eb93c8320b442170fbd08b03c OK
2025/06/27 08:09:57 DEBUG : both12: md5 = a2d3140aa9536230ed3c2b6710b10594 OK
2025/06/27 08:10:02 DEBUG : only12: md5 = 2a1a683fc877dd676abc3bd7b0bc628c OK
2025/06/27 08:10:02 DEBUG : both13: md5 = 0a42798c5fcb90788f4ae18d4a8d0a93 OK
2025/06/27 08:10:02 DEBUG : only13: md5 = 7b642f8f89311798bda25ccdff94f255 OK
2025/06/27 08:10:02 DEBUG : both14: md5 = 6be2d17e8d21cb02bfb50242bd5ce608 OK
2025/06/27 08:10:07 DEBUG : only14: md5 = 9d37ba8db347baf1bcca8f08e851c5d8 OK
2025/06/27 08:10:13 DEBUG : both15: md5 = aeed95ef1d93b5259ac087512383fefc OK
2025/06/27 08:10:13 DEBUG : only15: md5 = 6496f87f780da27cfc2cd000488d4025 OK
2025/06/27 08:10:13 DEBUG : both16: md5 = 0ff8fcb184900b1ce9ea6af93626e507 OK
2025/06/27 08:10:13 DEBUG : only16: md5 = aab5d695277fdebac57febb25d0187f9 OK
2025/06/27 08:10:18 DEBUG : both17: md5 = 8dec05a8e21f52648b400c625c8c67ea OK
2025/06/27 08:10:23 DEBUG : only17: md5 = 41df6d04efa83f15ee641351cd213071 OK
2025/06/27 08:10:28 DEBUG : both18: md5 = 25e0925990d2ccc0281c3fa4a90a8634 OK
2025/06/27 08:10:34 DEBUG : only18: md5 = 9fb50d78a98813cea39e5000752471ed OK
2025/06/27 08:10:34 DEBUG : both19: md5 = 137a22491457f1cb30c1557a6ee2c48c OK
2025/06/27 08:10:39 DEBUG : only19: md5 = 3ff9803472638ec265b587ce67c4b755 OK
2025/06/27 08:11:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for checks to finish
2025/06/27 08:11:31 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:31 DEBUG : both11: Unchanged skipping
2025/06/27 08:11:31 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:31 DEBUG : both12: Unchanged skipping
2025/06/27 08:11:31 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:31 DEBUG : both13: Unchanged skipping
2025/06/27 08:11:31 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:31 DEBUG : both14: Unchanged skipping
2025/06/27 08:11:31 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:31 DEBUG : both15: Unchanged skipping
2025/06/27 08:11:31 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:31 DEBUG : both16: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both10: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both19: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both1: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both0: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both2: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both3: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both4: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both5: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both6: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both17: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both7: Unchanged skipping
2025/06/27 08:11:36 DEBUG : only0: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only10: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only11: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only12: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only13: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only14: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only15: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only16: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only17: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only18: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only19: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only1: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only2: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only3: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only4: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only5: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only6: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only7: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only8: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : only9: Sizes differ (src 0 vs dst 6)
2025/06/27 08:11:36 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both18: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both8: Unchanged skipping
2025/06/27 08:11:36 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/27 08:11:36 DEBUG : both9: Unchanged skipping
2025/06/27 08:11:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wediner7qeha': Waiting for transfers to finish
2025/06/27 08:11:36 DEBUG : only10: md5 = 9344c2df1915aedf5f75e39c087689cd OK
2025/06/27 08:11:36 INFO  : only10: Copied (replaced existing)
2025/06/27 08:11:36 DEBUG : only11: md5 = 935d304eaddca109ae082fcbb3edbc3a OK
2025/06/27 08:11:36 INFO  : only11: Copied (replaced existing)
2025/06/27 08:11:37 DEBUG : only13: md5 = cf0c97829ca865689667dfb0430af569 OK
2025/06/27 08:11:37 INFO  : only13: Copied (replaced existing)
2025/06/27 08:11:37 DEBUG : only15: md5 = f0c78cd4b931dbbe1b43ad5c1386c59a OK
2025/06/27 08:11:37 INFO  : only15: Copied (replaced existing)
2025/06/27 08:11:37 DEBUG : only16: md5 = 6be1950cd05cca854cd432a2d453dd8e OK
2025/06/27 08:11:37 INFO  : only16: Copied (replaced existing)
2025/06/27 08:11:42 DEBUG : only12: md5 = a4879c97865753c745266be692a093d3 OK
2025/06/27 08:11:42 INFO  : only12: Copied (replaced existing)
2025/06/27 08:11:42 DEBUG : only14: md5 = f7f44065e72e37a510f81f040069ee2a OK
2025/06/27 08:11:42 INFO  : only14: Copied (replaced existing)
2025/06/27 08:11:42 DEBUG : only17: md5 = b2c000d50b39393afbe2efef95356c32 OK
2025/06/27 08:11:42 INFO  : only17: Copied (replaced existing)
2025/06/27 08:11:42 DEBUG : only1: md5 = a66cb1677f356cab85b4beae114e732c OK
2025/06/27 08:11:42 INFO  : only1: Copied (replaced existing)
2025/06/27 08:11:46 DEBUG : only0: md5 = 8ac66e775c3ac99fff9c59118c35b219 OK
2025/06/27 08:11:46 INFO  : only0: Copied (replaced existing)
2025/06/27 08:11:47 DEBUG : only19: md5 = ac434c8101fa48cba65fdcce185463fd OK
2025/06/27 08:11:47 INFO  : only19: Copied (replaced existing)
2025/06/27 08:11:47 DEBUG : only4: md5 = 331fb223809ec4c08855e1e8d72f3ccf OK
2025/06/27 08:11:47 INFO  : only4: Copied (replaced existing)
2025/06/27 08:11:47 DEBUG : only2: md5 = 639ece666228323ae15877d1cb4db36d OK
2025/06/27 08:11:47 INFO  : only2: Copied (replaced existing)
2025/06/27 08:11:48 DEBUG : only6: md5 = 839bf27a3a8312851a79485d34d25e68 OK
2025/06/27 08:11:48 INFO  : only6: Copied (replaced existing)
2025/06/27 08:11:48 DEBUG : only7: md5 = 2a2a4ea22caedfcbaf6b39705642ed9e OK
2025/06/27 08:11:48 INFO  : only7: Copied (replaced existing)
2025/06/27 08:11:48 DEBUG : only8: md5 = c1504d3553e5bd862115ee576d55ee72 OK
2025/06/27 08:11:48 INFO  : only8: Copied (replaced existing)
2025/06/27 08:11:51 DEBUG : only3: md5 = 96f85fd3d502d5dff75f1f927007e68c OK
2025/06/27 08:11:51 INFO  : only3: Copied (replaced existing)
2025/06/27 08:11:52 DEBUG : only18: md5 = a39b27b580255ff62d00c137d63122fc OK
2025/06/27 08:11:52 INFO  : only18: Copied (replaced existing)
2025/06/27 08:11:53 DEBUG : only5: md5 = 8a6d660e823235b95a5afae3b712bea1 OK
2025/06/27 08:11:53 INFO  : only5: Copied (replaced existing)
2025/06/27 08:11:53 DEBUG : only9: md5 = 0f58e466fb583a184ca4491378f171b8 OK
2025/06/27 08:11:53 INFO  : only9: Copied (replaced existing)
2025/06/27 08:11:53 DEBUG : Waiting for deletions to finish
panic: test timed out after 1h0m0s
	running tests:
		TestSyncConcurrentTruncate (4m7s)

goroutine 12781 [running]:
testing.(*M).startAlarm.func1()
	/usr/local/go/src/testing/testing.go:2484 +0x394
created by time.goFunc
	/usr/local/go/src/time/sleep.go:215 +0x2d

goroutine 1 [chan receive, 4 minutes]:
testing.(*T).Run(0xc000103880, {0x26c085a?, 0xc00006bad8?}, 0x27c2a88)
	/usr/local/go/src/testing/testing.go:1859 +0x431
testing.runTests.func1(0xc000103880)
	/usr/local/go/src/testing/testing.go:2279 +0x37
testing.tRunner(0xc000103880, 0xc00006bc18)
	/usr/local/go/src/testing/testing.go:1792 +0xf4
testing.runTests(0xc000693518, {0x3e80600, 0x6b, 0x6b}, {0xedff03b64?, 0x3e965c0?, 0x3e965c0?})
	/usr/local/go/src/testing/testing.go:2277 +0x4b4
testing.(*M).Run(0xc0002f4820)
	/usr/local/go/src/testing/testing.go:2142 +0x64a
github.com/rclone/rclone/fstest.TestMain(0xc0002f4820)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:69 +0xa5
github.com/rclone/rclone/fs/sync.TestMain(...)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:45
main.main()
	_testmain.go:259 +0xa9

goroutine 35 [syscall, 60 minutes]:
os/signal.signal_recv()
	/usr/local/go/src/runtime/sigqueue.go:152 +0x29
os/signal.loop()
	/usr/local/go/src/os/signal/signal_unix.go:23 +0x13
created by os/signal.Notify.func1.1 in goroutine 1
	/usr/local/go/src/os/signal/signal.go:152 +0x1f

goroutine 36 [chan receive, 60 minutes]:
github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27
created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7

goroutine 12266 [select]:
github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc0003961e0, 0xc000344540, 0xc000c09400)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115
github.com/ncw/swift/v2.(*Connection).Call(0xc0003961e0, {0x2af5d08, 0x3eb9b80}, {0xc0019d7270, 0x4f}, {{0xc00225b740, 0x5}, {0xc00225b746, 0x22}, {0x2682b12, ...}, ...})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6
github.com/ncw/swift/v2.(*Connection).storage(0xc0003961e0, {0x2af5d08, 0x3eb9b80}, {{0xc00225b740, 0x5}, {0xc00225b746, 0x22}, {0x2682b12, 0x6}, 0x0, ...})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:847 +0x151
github.com/ncw/swift/v2.(*Connection).ObjectDelete(...)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:1902
github.com/rclone/rclone/backend/swift.(*Object).Remove.func1()
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1620 +0x105
github.com/rclone/rclone/fs.pacerInvoker(0x1, 0xa, 0xc000053808?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc001a88000, 0xc000970d20, 0xa)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:199 +0x7c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc001a88000, 0xc000970d20)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:218 +0x93
github.com/rclone/rclone/backend/swift.(*Object).Remove(0xc000c0c540, {0x2af5d08, 0x3eb9b80})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1619 +0x29b
github.com/rclone/rclone/fstest.newRunIndividual.func1.1.1()
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x24
github.com/rclone/rclone/fstest.retry(0xc002078700, {0xc0017b83d8, 0x15}, 0xc00006b8c8)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:121 +0xde
github.com/rclone/rclone/fstest.newRunIndividual.func1.1({0xc000900488?, 0xc000900488?, 0x1e03d74?})
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x29a
github.com/rclone/rclone/fs/walk.listR.func1({0xc000900488, 0x28, 0x47})
	/home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:331 +0x1ca
github.com/rclone/rclone/backend/crypt.(*Fs).ListR.func1({0xc000900488?, 0xc002032760?, 0x5?})
	/home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:481 +0x5b
github.com/rclone/rclone/fs/list.(*Helper).send(...)
	/home/rclone/go/src/github.com/rclone/rclone/fs/list/helpers.go:29
github.com/rclone/rclone/fs/list.(*Helper).Flush(0xc00006bb30)
	/home/rclone/go/src/github.com/rclone/rclone/fs/list/helpers.go:47 +0x35
github.com/rclone/rclone/backend/swift.(*Fs).ListR(0xc001a8a000, {0x2af5d08, 0x3eb9b80}, {0x0?, 0x2417cc0?}, 0xc00047e300)
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:881 +0x185
github.com/rclone/rclone/backend/crypt.(*Fs).ListR(0xc0004c1790, {0x2af5d08, 0x3eb9b80}, {0x0, 0x0}, 0xc0003c2f00)
	/home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:476 +0x118
github.com/rclone/rclone/fs/walk.listR({0x2af5d08, 0x3eb9b80}, {0x2b0a480, 0xc0004c1790}, {0x0, 0x0}, 0x1, 0x3, 0xc00047e120, 0xc000693140, ...)
	/home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:299 +0x292
github.com/rclone/rclone/fs/walk.ListR({0x2af5d08, 0x3eb9b80}, {0x2b0a480, 0xc0004c1790}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc00047e120)
	/home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:163 +0x1d5
github.com/rclone/rclone/fstest.newRunIndividual.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:150 +0x107
github.com/rclone/rclone/fstest.(*Run).Finalise(0xc00032a8c0)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 +0x1c
testing.(*common).Cleanup.func1()
	/usr/local/go/src/testing/testing.go:1211 +0x106
testing.(*common).runCleanup(0xc002078700, 0x8?)
	/usr/local/go/src/testing/testing.go:1445 +0xea
testing.tRunner.func2()
	/usr/local/go/src/testing/testing.go:1786 +0x25
testing.tRunner(0xc002078700, 0x27c2a88)
	/usr/local/go/src/testing/testing.go:1798 +0x11e
created by testing.(*T).Run in goroutine 1
	/usr/local/go/src/testing/testing.go:1851 +0x413

goroutine 11974 [select, 2 minutes]:
net/http.(*persistConn).writeLoop(0xc00061d320)
	/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 11928
	/usr/local/go/src/net/http/transport.go:1945 +0x17a5

goroutine 12427 [select, 2 minutes]:
net/http.(*persistConn).writeLoop(0xc000560240)
	/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 12467
	/usr/local/go/src/net/http/transport.go:1945 +0x17a5

goroutine 12472 [select, 2 minutes]:
net/http.(*persistConn).writeLoop(0xc0004a17a0)
	/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 12453
	/usr/local/go/src/net/http/transport.go:1945 +0x17a5

goroutine 12471 [IO wait, 2 minutes]:
internal/poll.runtime_pollWait(0x791d8e1c8160, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc0001fa280?, 0xc0001e0600?, 0x0)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0xc0001fa280, {0xc0001e0600, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc0001fa280, {0xc0001e0600?, 0x1973?, 0xc00207fe00?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0003b8468, {0xc0001e0600?, 0xc00035bdd0?, 0xd?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000693578, {0xc0001e0600?, 0x791d75d7d728?, 0x791dd56a0a78?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc001cfcb88, {0xc0001e0600?, 0x1973?, 0xc00084f9d0?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc00035beb8, {0x2ad0720, 0xc001cfcb88})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc00035bc08, {0x791d77fdacd8, 0xc000693578}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc00035bc08, 0x0)
	/usr/local/go/src/crypto/tls/conn.go:629 +0x3cf
crypto/tls.(*Conn).readRecord(...)
	/usr/local/go/src/crypto/tls/conn.go:591
crypto/tls.(*Conn).Read(0xc00035bc08, {0xc00057b000, 0x1000, 0xc000443260?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc0004a17a0, {0xc00057b000?, 0x7f4fc5?, 0x2acd640?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc001d26c00)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc001d26c00, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc0004a17a0)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 12453
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

goroutine 2084 [chan receive, 53 minutes]:
github.com/rclone/rclone/lib/atexit.Register.func1.1()
	/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:45 +0x29
created by github.com/rclone/rclone/lib/atexit.Register.func1 in goroutine 2061
	/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68

goroutine 12426 [IO wait, 2 minutes]:
internal/poll.runtime_pollWait(0x791d8e1c8390, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc001be4600?, 0xc0001dec80?, 0x0)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0xc001be4600, {0xc0001dec80, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc001be4600, {0xc0001dec80?, 0x41d4ae?, 0xc00207fba0?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc001cfa028, {0xc0001dec80?, 0x791d75d7d728?, 0x6?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0017150c8, {0xc0001dec80?, 0x791d75d7d728?, 0x791dd56a0a78?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc001cfcbe8, {0xc0001dec80?, 0x1973?, 0xc0009799d0?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc00050c2b8, {0x2ad0720, 0xc001cfcbe8})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc00050c008, {0x791d77fdacd8, 0xc0017150c8}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc00050c008, 0x0)
	/usr/local/go/src/crypto/tls/conn.go:629 +0x3cf
crypto/tls.(*Conn).readRecord(...)
	/usr/local/go/src/crypto/tls/conn.go:591
crypto/tls.(*Conn).Read(0xc00050c008, {0xc00075e000, 0x1000, 0xc000443260?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000560240, {0xc00075e000?, 0x7f4fc5?, 0x2acd640?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc002059620)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc002059620, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000560240)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 12467
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

goroutine 12798 [select]:
net/http.(*persistConn).roundTrip(0xc00048a900, 0xc000970dc0)
	/usr/local/go/src/net/http/transport.go:2826 +0x785
net/http.(*Transport).roundTrip(0xc00069c000, 0xc000c09400)
	/usr/local/go/src/net/http/transport.go:696 +0xb9a
net/http.(*Transport).RoundTrip(...)
	/usr/local/go/src/net/http/roundtrip.go:30
github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc0003ee770, 0xc000c09400)
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345
net/http.send(0xc000c09400, {0x2acf1c0, 0xc0003ee770}, {0x41b001?, 0xc001d93d80?, 0x0?})
	/usr/local/go/src/net/http/client.go:259 +0x5e2
net/http.(*Client).send(0xc001a2c000, 0xc000c09400, {0x8000000025f0300?, 0xc00052fe00?, 0x0?})
	/usr/local/go/src/net/http/client.go:180 +0x91
net/http.(*Client).do(0xc001a2c000, 0xc000c09400)
	/usr/local/go/src/net/http/client.go:728 +0x989
net/http.(*Client).Do(...)
	/usr/local/go/src/net/http/client.go:587
github.com/ncw/swift/v2.(*Connection).doTimeoutRequest.func1()
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:421 +0x2b
created by github.com/ncw/swift/v2.(*Connection).doTimeoutRequest in goroutine 12266
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8

goroutine 11973 [IO wait, 2 minutes]:
internal/poll.runtime_pollWait(0x791d8e1c86d8, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc001be4780?, 0xc0006bc000?, 0x0)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0xc001be4780, {0xc0006bc000, 0x3500, 0x3500})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc001be4780, {0xc0006bc000?, 0x34f3?, 0xc0005955a0?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0003b8698, {0xc0006bc000?, 0xc000650550?, 0xd?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000693e00, {0xc0006bc000?, 0x791d77fd8098?, 0x791dd56a0108?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc001753548, {0xc0006bc000?, 0x34f3?, 0xc0004b99d0?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000650638, {0x2ad0720, 0xc001753548})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000650388, {0x791d77fdacd8, 0xc000693e00}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000650388, 0x0)
	/usr/local/go/src/crypto/tls/conn.go:629 +0x3cf
crypto/tls.(*Conn).readRecord(...)
	/usr/local/go/src/crypto/tls/conn.go:591
crypto/tls.(*Conn).Read(0xc000650388, {0xc0006a9000, 0x1000, 0xc000443260?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc00061d320, {0xc0006a9000?, 0x7f4fc5?, 0x2acd640?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc0022216e0)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc0022216e0, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc00061d320)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 11928
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

goroutine 12429 [select]:
net/http.(*persistConn).writeLoop(0xc00048a900)
	/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 12483
	/usr/local/go/src/net/http/transport.go:1945 +0x17a5

goroutine 12428 [IO wait]:
internal/poll.runtime_pollWait(0x791d8e1c8278, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc001e32880?, 0xc000c88000?, 0x0)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0xc001e32880, {0xc000c88000, 0x3500, 0x3500})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc001e32880, {0xc000c88000?, 0x34f3?, 0xc0002e2240?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc000124408, {0xc000c88000?, 0xc0006508d0?, 0xd?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0019d9098, {0xc000c88000?, 0x791d8d19ede0?, 0x791dd56a0108?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc00207b470, {0xc000c88000?, 0x34f3?, 0xc0007ba9d0?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0006509b8, {0x2ad0720, 0xc00207b470})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000650708, {0x791d77fdacd8, 0xc0019d9098}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000650708, 0x0)
	/usr/local/go/src/crypto/tls/conn.go:629 +0x3cf
crypto/tls.(*Conn).readRecord(...)
	/usr/local/go/src/crypto/tls/conn.go:591
crypto/tls.(*Conn).Read(0xc000650708, {0xc000760000, 0x1000, 0xc000443260?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc00048a900, {0xc000760000?, 0x7f4fc5?, 0x2acd640?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc002059860)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc002059860, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc00048a900)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 12483
	/usr/local/go/src/net/http/transport.go:1944 +0x174f
"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished ERROR in 1h0m11.234749669s (try 4/5): exit status 2: Failed []