"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5)
2025/06/22 01:31:05 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi"
2025/06/22 01:31:05 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/06/22 01:31:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi.bin"
2025/06/22 01:31:05 DEBUG : Swift container crypt path rclone-test-danexug2wuvi.bin: Auto set use_segments_container to true
2025/06/22 01:31:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi"
2025/06/22 01:31:11 DEBUG : Swift container crypt path rclone-test-danexug2wuvi: Auto set use_segments_container to true
2025/06/22 01:31:16 DEBUG : Creating backend with remote "/tmp/rclone3055348682"
=== 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-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:31:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:31:16 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11)
2025/06/22 01:31:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:31:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
--- PASS: TestCopyWithDryRun (0.40s)
=== RUN   TestCopy
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:31:17 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/06/22 01:31:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:31:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:31:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:31:22 DEBUG : sub dir/hello world: md5 = 9e43e2256caf50794416137f15ecd46e OK
2025/06/22 01:31:22 INFO  : sub dir/hello world: Copied (new)
2025/06/22 01:31:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestCopy (11.36s)
=== RUN   TestCopyMetadata
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:98: Skipping as metadata not supported
--- SKIP: TestCopyMetadata (0.20s)
=== RUN   TestCopyMetadataNoEmptyDirs
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:98: Skipping as metadata not supported
--- SKIP: TestCopyMetadataNoEmptyDirs (0.20s)
=== RUN   TestCopyMissingDirectory
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:31:28 DEBUG : Creating backend with remote "/non-existing"
2025/06/22 01:31:28 ERROR : Local file system at /non-existing: error reading source root directory: directory not found
2025/06/22 01:31:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:31:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
--- PASS: TestCopyMissingDirectory (0.30s)
=== RUN   TestCopyNoTraverse
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:31:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:31:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:31:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:31:39 DEBUG : sub dir/hello world: md5 = e61697db9aef5f33c57c0a8f1799579c OK
2025/06/22 01:31:39 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyNoTraverse (21.34s)
=== RUN   TestCopyCheckFirst
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:31:50 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Running all checks before starting transfers
2025/06/22 01:31:50 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:31:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:31:50 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Checks finished, now starting transfers
2025/06/22 01:31:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:31:55 DEBUG : sub dir/hello world: md5 = 52397de550a688f5d3745e1a9a4db4b9 OK
2025/06/22 01:31:55 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyCheckFirst (11.46s)
=== RUN   TestSyncNoTraverse
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:32:01 ERROR : Ignoring --no-traverse with sync
2025/06/22 01:32:02 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:32:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:32:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:32:07 DEBUG : sub dir/hello world: md5 = 6e212d3b9f941b89b90109c19dbec017 OK
2025/06/22 01:32:07 INFO  : sub dir/hello world: Copied (new)
2025/06/22 01:32:07 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoTraverse (11.32s)
=== RUN   TestCopyWithDepth
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:32:13 DEBUG : hello world2: Need to transfer - File not found at Destination
2025/06/22 01:32:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:32:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:32:18 DEBUG : hello world2: md5 = bc15a3bdf265d3cdc7f75c6cea3e4bd9 OK
2025/06/22 01:32:18 INFO  : hello world2: Copied (new)
--- PASS: TestCopyWithDepth (16.21s)
=== RUN   TestCopyWithFilesFrom
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:32:29 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:32:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:32:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:32:35 DEBUG : potato2: md5 = 1741be34ef7208d1b480491c85efab37 OK
2025/06/22 01:32:35 INFO  : potato2: Copied (new)
--- PASS: TestCopyWithFilesFrom (11.11s)
=== RUN   TestCopyWithFilesFromAndNoTraverse
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:32:45 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:32:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:32:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:32:50 DEBUG : potato2: md5 = a6ff334448d471d8218353f713054b60 OK
2025/06/22 01:32:50 INFO  : potato2: Copied (new)
--- PASS: TestCopyWithFilesFromAndNoTraverse (21.07s)
=== RUN   TestCopyEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:33:01 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2025/06/22 01:33:01 INFO  : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/06/22 01:33:01 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2025/06/22 01:33:01 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/06/22 01:33:01 INFO  : sub dir2: Making directory
2025/06/22 01:33:01 INFO  : sub dir: Making directory
2025/06/22 01:33:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:33:01 INFO  : sub dir2/sub sub dir2: Making directory
2025/06/22 01:33:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:33:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:33:07 DEBUG : sub dir/hello world: md5 = 5db7449d1115039f79377c5309efc080 OK
2025/06/22 01:33:07 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/22 01:33:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestCopyEmptyDirectories (16.08s)
=== RUN   TestCopyNoEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:33:17 INFO  : sub dir2: Making directory
2025/06/22 01:33:17 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2025/06/22 01:33:17 INFO  : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/06/22 01:33:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:33:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:33:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:33:23 DEBUG : sub dir/hello world: md5 = e2f79a39ad0652cd9bcb3d8be3807682 OK
2025/06/22 01:33:23 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyNoEmptyDirectories (16.99s)
=== RUN   TestMoveEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:33:34 DEBUG : sub dir2: Making directory with metadata
2025/06/22 01:33:34 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/06/22 01:33:34 INFO  : sub dir2: Making directory
2025/06/22 01:33:34 INFO  : sub dir: Making directory
2025/06/22 01:33:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:33:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:33:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:33:40 DEBUG : sub dir/hello world: md5 = 54ffdf0da083127cd72ca7f6217e44ed OK
2025/06/22 01:33:40 INFO  : sub dir/hello world: Copied (new)
2025/06/22 01:33:40 INFO  : sub dir/hello world: Deleted
    fstest.go:247: Filtering empty directory "sub dir2"
2025/06/22 01:33:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
2025/06/22 01:33:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestMoveEmptyDirectories (21.39s)
=== RUN   TestSyncNoUpdateDirModtime
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:409: Skipping test as backend does not support DirSetModTime
--- SKIP: TestSyncNoUpdateDirModtime (0.25s)
=== RUN   TestMoveNoEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:33:56 INFO  : sub dir2: Making directory
2025/06/22 01:33:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:33:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:33:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:34:01 DEBUG : sub dir/hello world: md5 = 80a3ffffe568a542fe6eacff20cc8abd OK
2025/06/22 01:34:01 INFO  : sub dir/hello world: Copied (new)
2025/06/22 01:34:01 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveNoEmptyDirectories (20.86s)
=== RUN   TestSyncEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:34:17 DEBUG : sub dir2: Making directory with metadata
2025/06/22 01:34:17 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/06/22 01:34:17 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/06/22 01:34:17 INFO  : sub dir2: Making directory
2025/06/22 01:34:17 INFO  : sub dir: Making directory
2025/06/22 01:34:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:34:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:34:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:34:22 DEBUG : sub dir/hello world: md5 = 94e43be4233b3a950e9cbe4dea37f3ee OK
2025/06/22 01:34:22 INFO  : sub dir/hello world: Copied (new)
2025/06/22 01:34:22 DEBUG : Waiting for deletions to finish
    fstest.go:247: Filtering empty directory "sub dir2"
2025/06/22 01:34:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestSyncEmptyDirectories (11.24s)
=== RUN   TestSyncSetDelayedModTimes
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:508: Backend doesn't have DirModTimeUpdatesOnWrite set
--- SKIP: TestSyncSetDelayedModTimes (0.37s)
=== RUN   TestSyncNoEmptyDirectories
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:34:28 INFO  : sub dir2: Making directory
2025/06/22 01:34:28 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:34:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:34:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:34:34 DEBUG : sub dir/hello world: md5 = 1093e344774fce59866bf4b465c4b785 OK
2025/06/22 01:34:34 INFO  : sub dir/hello world: Copied (new)
2025/06/22 01:34:34 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoEmptyDirectories (11.21s)
=== RUN   TestServerSideCopy
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:34:45 DEBUG : sub dir/hello world: md5 = 204f176d3d39662e386443299fbc4191 OK
2025/06/22 01:34:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kotumoz0melu"
2025/06/22 01:34:45 DEBUG : Config file has changed externally - reloading
2025/06/22 01:34:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kotumoz0melu.bin"
2025/06/22 01:34:46 DEBUG : Swift container crypt path rclone-test-kotumoz0melu.bin: Auto set use_segments_container to true
2025/06/22 01:34:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kotumoz0melu"
2025/06/22 01:34:51 DEBUG : Swift container crypt path rclone-test-kotumoz0melu: Auto set use_segments_container to true
    sync_test.go:591: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi' -> Encrypted drive 'TestCryptSwift:rclone-test-kotumoz0melu'
2025/06/22 01:34:57 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:34:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kotumoz0melu': Waiting for checks to finish
2025/06/22 01:34:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kotumoz0melu': Waiting for transfers to finish
2025/06/22 01:35:03 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/22 01:35:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kotumoz0melu': Purge remote
2025/06/22 01:35:03 DEBUG : Waiting for deletions to finish
2025/06/22 01:35:03 INFO  : sub dir/hello world.bin: Deleted
--- PASS: TestServerSideCopy (29.28s)
=== RUN   TestCopyOverSelf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:35:14 DEBUG : sub dir/hello world: md5 = b5da5c2d9652829309961f2c1bf0267d OK
2025/06/22 01:35:15 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/06/22 01:35:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:35:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:35:43 DEBUG : sub dir/hello world: md5 = c2c1ffe003f2e36c313fd3a373bdc03d OK
2025/06/22 01:35:43 INFO  : sub dir/hello world: Copied (replaced existing)
--- PASS: TestCopyOverSelf (45.03s)
=== RUN   TestServerSideCopyOverSelf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:35:59 DEBUG : sub dir/hello world: md5 = 390356f9450cbadc8ae8d0fcd51e4944 OK
2025/06/22 01:36:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kemafoz6muti"
2025/06/22 01:36:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kemafoz6muti.bin"
2025/06/22 01:36:05 DEBUG : Swift container crypt path rclone-test-kemafoz6muti.bin: Auto set use_segments_container to true
2025/06/22 01:36:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kemafoz6muti"
2025/06/22 01:36:10 DEBUG : Swift container crypt path rclone-test-kemafoz6muti: Auto set use_segments_container to true
    sync_test.go:627: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi' -> Encrypted drive 'TestCryptSwift:rclone-test-kemafoz6muti'
2025/06/22 01:36:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:36:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kemafoz6muti': Waiting for checks to finish
2025/06/22 01:36:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kemafoz6muti': Waiting for transfers to finish
2025/06/22 01:36:32 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/22 01:36:37 DEBUG : sub dir/hello world: md5 = a556e650a251ebc9578c0809be9adf84 OK
2025/06/22 01:36:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kemafoz6muti': Waiting for checks to finish
2025/06/22 01:36:38 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/06/22 01:36:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kemafoz6muti': Waiting for transfers to finish
2025/06/22 01:36:49 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/22 01:36:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kemafoz6muti': Purge remote
2025/06/22 01:36:49 DEBUG : Waiting for deletions to finish
2025/06/22 01:36:54 INFO  : sub dir/hello world.bin: Deleted
--- PASS: TestServerSideCopyOverSelf (70.82s)
=== RUN   TestMoveOverSelf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:37:10 DEBUG : sub dir/hello world: md5 = ca71e0b093924bdc81b3b17e40971736 OK
2025/06/22 01:37:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:37:10 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/06/22 01:37:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:37:16 DEBUG : sub dir/hello world: md5 = fb7fd5f245c1dea6fd09b2651cbb4a70 OK
2025/06/22 01:37:16 INFO  : sub dir/hello world: Copied (replaced existing)
2025/06/22 01:37:16 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveOverSelf (16.78s)
=== RUN   TestServerSideMoveOverSelf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:37:27 DEBUG : sub dir/hello world: md5 = 2e51144a79ff503e9ed13b03406ad2ea OK
2025/06/22 01:37:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xegaceq8vebe"
2025/06/22 01:37:27 DEBUG : Config file has changed externally - reloading
2025/06/22 01:37:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xegaceq8vebe.bin"
2025/06/22 01:37:27 DEBUG : Swift container crypt path rclone-test-xegaceq8vebe.bin: Auto set use_segments_container to true
2025/06/22 01:37:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xegaceq8vebe"
2025/06/22 01:37:33 DEBUG : Swift container crypt path rclone-test-xegaceq8vebe: Auto set use_segments_container to true
    sync_test.go:672: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi' -> Encrypted drive 'TestCryptSwift:rclone-test-xegaceq8vebe'
2025/06/22 01:37:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:37:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xegaceq8vebe': Waiting for checks to finish
2025/06/22 01:37:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xegaceq8vebe': Waiting for transfers to finish
2025/06/22 01:37:59 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/22 01:38:09 DEBUG : sub dir/hello world: md5 = 9d638c9b1f97c30288319dea8ccdeb4d OK
2025/06/22 01:38:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xegaceq8vebe': Waiting for checks to finish
2025/06/22 01:38:10 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/06/22 01:38:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xegaceq8vebe': Waiting for transfers to finish
2025/06/22 01:38:25 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/22 01:38:30 INFO  : sub dir/hello world: Deleted
2025/06/22 01:38:41 DEBUG : sub dir/hello world: md5 = 6c8a94cabe34411cae07b382114ccbc6 OK
2025/06/22 01:38:41 DEBUG : testing file moves
2025/06/22 01:38:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xegaceq8vebe': Waiting for checks to finish
2025/06/22 01:38:41 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17)
2025/06/22 01:38:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xegaceq8vebe': Waiting for transfers to finish
2025/06/22 01:38:57 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/22 01:39:02 INFO  : sub dir/hello world: Deleted
2025/06/22 01:39:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xegaceq8vebe': Purge remote
2025/06/22 01:39:03 DEBUG : Waiting for deletions to finish
2025/06/22 01:39:08 INFO  : sub dir/hello world.bin: Deleted
--- PASS: TestServerSideMoveOverSelf (106.64s)
=== RUN   TestCopyAfterDelete
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:39:13 DEBUG : sub dir/hello world: md5 = 488f396a7a6b2545b654a96fb9cf2bd8 OK
2025/06/22 01:39:13 ERROR : error listing: directory not found
2025/06/22 01:39:14 INFO  : Local file system at /tmp/rclone3055348682: Making directory
2025/06/22 01:39:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:39:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
--- PASS: TestCopyAfterDelete (21.45s)
=== RUN   TestCopyRedownload
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:39:35 DEBUG : sub dir/hello world: md5 = d67424cc42b3674ee8e98922a932fdba OK
2025/06/22 01:39:40 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:39:40 DEBUG : Local file system at /tmp/rclone3055348682: Waiting for checks to finish
2025/06/22 01:39:40 DEBUG : Local file system at /tmp/rclone3055348682: Waiting for transfers to finish
2025/06/22 01:39:40 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/06/22 01:39:40 INFO  : sub dir/hello world: Copied (new)
--- PASS: TestCopyRedownload (16.30s)
=== RUN   TestSyncBasedOnCheckSum
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:39:46 DEBUG : check sum: Need to transfer - File not found at Destination
2025/06/22 01:39:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:39:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:39:51 DEBUG : check sum: md5 = a6cc037c53120f75f0c6d002db69e263 OK
2025/06/22 01:39:51 INFO  : check sum: Copied (new)
2025/06/22 01:39:51 DEBUG : Waiting for deletions to finish
2025/06/22 01:39:56 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only
2025/06/22 01:39:56 DEBUG : check sum: Size of src and dst objects identical
2025/06/22 01:39:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:40:02 DEBUG : check sum: Unchanged skipping
2025/06/22 01:40:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:40:02 DEBUG : Waiting for deletions to finish
2025/06/22 01:40:02 INFO  : There was nothing to transfer
--- PASS: TestSyncBasedOnCheckSum (21.11s)
=== RUN   TestSyncSizeOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:40:07 DEBUG : sizeonly: Need to transfer - File not found at Destination
2025/06/22 01:40:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:40:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:40:07 DEBUG : sizeonly: md5 = fa6c0316d3a2cbff89f2278f53ceaab1 OK
2025/06/22 01:40:07 INFO  : sizeonly: Copied (new)
2025/06/22 01:40:07 DEBUG : Waiting for deletions to finish
2025/06/22 01:40:08 DEBUG : sizeonly: Sizes identical
2025/06/22 01:40:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:40:08 DEBUG : sizeonly: Unchanged skipping
2025/06/22 01:40:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:40:08 DEBUG : Waiting for deletions to finish
2025/06/22 01:40:08 INFO  : There was nothing to transfer
--- PASS: TestSyncSizeOnly (1.24s)
=== RUN   TestSyncIgnoreSize
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:40:08 DEBUG : ignore-size: Need to transfer - File not found at Destination
2025/06/22 01:40:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:40:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:40:09 DEBUG : ignore-size: md5 = b12df845ce7a2e8b97ebeff1872af21f OK
2025/06/22 01:40:09 INFO  : ignore-size: Copied (new)
2025/06/22 01:40:09 DEBUG : Waiting for deletions to finish
2025/06/22 01:40:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:40:10 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:40:10 DEBUG : ignore-size: Unchanged skipping
2025/06/22 01:40:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:40:10 DEBUG : Waiting for deletions to finish
2025/06/22 01:40:10 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreSize (1.99s)
=== RUN   TestSyncIgnoreTimes
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:40:15 DEBUG : existing: md5 = 09220073460a49cdf9e5a67035f606d3 OK
2025/06/22 01:40:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:40:21 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:40:21 DEBUG : existing: Unchanged skipping
2025/06/22 01:40:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:40:21 DEBUG : Waiting for deletions to finish
2025/06/22 01:40:21 INFO  : There was nothing to transfer
2025/06/22 01:40:21 DEBUG : existing: Transferring unconditionally as --ignore-times is in use
2025/06/22 01:40:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:40:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:40:26 DEBUG : existing: md5 = e3c3110a242a344004fbfbd8800dae7b OK
2025/06/22 01:40:26 INFO  : existing: Copied (replaced existing)
2025/06/22 01:40:26 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncIgnoreTimes (21.75s)
=== RUN   TestSyncIgnoreExisting
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:40:32 DEBUG : existing: Need to transfer - File not found at Destination
2025/06/22 01:40:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:40:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:40:37 DEBUG : existing: md5 = d1c085690ece17693dabc84f270542d2 OK
2025/06/22 01:40:37 INFO  : existing: Copied (new)
2025/06/22 01:40:37 DEBUG : Waiting for deletions to finish
2025/06/22 01:40:38 DEBUG : existing: Destination exists, skipping
2025/06/22 01:40:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:40:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:40:43 DEBUG : Waiting for deletions to finish
2025/06/22 01:40:43 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreExisting (26.32s)
=== RUN   TestSyncIgnoreErrors
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:41:04 DEBUG : b/potato: md5 = bd007a7f37df657146ab7579eb475804 OK
2025/06/22 01:41:04 DEBUG : c/non empty space: md5 = 80fa34eb549e3ab136e6c14808cf36cc OK
2025/06/22 01:41:04 INFO  : d: Making directory
    fstest.go:247: Filtering empty directory "d"
2025/06/22 01:41:04 DEBUG : a/potato2: Need to transfer - File not found at Destination
2025/06/22 01:41:04 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:41:04 DEBUG : c/non empty space: Unchanged skipping
2025/06/22 01:41:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:41:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:41:10 DEBUG : a/potato2: md5 = 7b7fc92282cad3aaceba9a217f54bab0 OK
2025/06/22 01:41:10 INFO  : a/potato2: Copied (new)
2025/06/22 01:41:10 DEBUG : Waiting for deletions to finish
2025/06/22 01:41:15 INFO  : b/potato: Deleted
--- PASS: TestSyncIgnoreErrors (22.23s)
=== RUN   TestSyncAfterChangingModtimeOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:41:22 DEBUG : empty space: md5 = e1836c7d46b60933007c5a3a34f7d227 OK
2025/06/22 01:41:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:41:22 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/22 01:41:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:41:22 NOTICE: empty space: Skipped copy as --dry-run is set (size 1)
2025/06/22 01:41:22 DEBUG : Waiting for deletions to finish
2025/06/22 01:41:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:41:22 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/22 01:41:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:41:23 DEBUG : empty space: md5 = 0df64e6b3d3d13b3b8939afbab574bc5 OK
2025/06/22 01:41:23 INFO  : empty space: Copied (replaced existing)
2025/06/22 01:41:23 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingModtimeOnly (2.84s)
=== RUN   TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:1017: Can't check this if no hashes supported
--- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.09s)
=== RUN   TestSyncDoesntUpdateModtime
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:41:29 DEBUG : foo: md5 = 438b8f734b0d144cbde80c5d4308fe1a OK
2025/06/22 01:41:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:41:34 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/22 01:41:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:41:39 DEBUG : foo: md5 = 876de2f146f5743fafe44489ba4e11b4 OK
2025/06/22 01:41:39 INFO  : foo: Copied (replaced existing)
2025/06/22 01:41:39 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncDoesntUpdateModtime (26.33s)
=== RUN   TestSyncAfterAddingAFile
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:41:50 DEBUG : empty space: md5 = a756348c34574cecbb030752092c72b1 OK
2025/06/22 01:41:50 DEBUG : potato: Need to transfer - File not found at Destination
2025/06/22 01:41:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:41:50 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:41:50 DEBUG : empty space: Unchanged skipping
2025/06/22 01:41:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:41:56 DEBUG : potato: md5 = ee61de920dfed1053531ee1cac337bdf OK
2025/06/22 01:41:56 INFO  : potato: Copied (new)
2025/06/22 01:41:56 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterAddingAFile (21.53s)
=== RUN   TestSyncAfterChangingFilesSizeOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:42:16 DEBUG : potato: md5 = f5beaf9ca4db078709f24012165370a7 OK
2025/06/22 01:42:22 DEBUG : potato: Sizes differ (src 21 vs dst 60)
2025/06/22 01:42:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:42:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:42:27 DEBUG : potato: md5 = 69922789ba52baf3e409344ee6667f8d OK
2025/06/22 01:42:27 INFO  : potato: Copied (replaced existing)
2025/06/22 01:42:27 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingFilesSizeOnly (25.96s)
=== RUN   TestSyncAfterChangingContentsOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:42:42 DEBUG : potato: md5 = bf5bb9e16ef44ee2e264a49c00a2ff04 OK
2025/06/22 01:42:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:42:48 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/22 01:42:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:42:53 DEBUG : potato: md5 = 9af3727fc8fcff7a0ef2508be47325a6 OK
2025/06/22 01:42:53 INFO  : potato: Copied (replaced existing)
2025/06/22 01:42:53 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncAfterChangingContentsOnly (26.10s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileDryRun
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:43:08 DEBUG : potato: md5 = 8ad87221c9a0f8f35ceb6cef2252c3f1 OK
2025/06/22 01:43:09 DEBUG : empty space: md5 = 2162737867ddd929e4db768a6b69c36a OK
2025/06/22 01:43:09 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:43:09 NOTICE: potato2: Skipped copy as --dry-run is set (size 60)
2025/06/22 01:43:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:43:09 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:43:09 DEBUG : empty space: Unchanged skipping
2025/06/22 01:43:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:43:09 DEBUG : Waiting for deletions to finish
2025/06/22 01:43:09 NOTICE: potato: Skipped delete as --dry-run is set (size 21)
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (21.11s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFile
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:43:30 DEBUG : potato: md5 = 2f0cd1fe8db3d3a10164b00cb238d25b OK
2025/06/22 01:43:30 DEBUG : empty space: md5 = bc18cd670732a6567f7c537ffbbc0b63 OK
2025/06/22 01:43:35 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:43:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:43:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:43:35 DEBUG : empty space: Unchanged skipping
2025/06/22 01:43:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:43:40 DEBUG : potato2: md5 = 79ab650562e1da847a3c60bfe9b5d30e OK
2025/06/22 01:43:40 INFO  : potato2: Copied (new)
2025/06/22 01:43:40 DEBUG : Waiting for deletions to finish
2025/06/22 01:43:45 INFO  : potato: Deleted
--- PASS: TestSyncAfterRemovingAFileAndAddingAFile (26.48s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDir
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:43:56 DEBUG : b/potato: md5 = a40f5653d88c596ce632fa83c1a5e098 OK
2025/06/22 01:43:56 DEBUG : c/non empty space: md5 = a2784ab8860f62094da5be2353e33ebb OK
2025/06/22 01:43:56 INFO  : d: Making directory
2025/06/22 01:43:56 INFO  : d/e: Making directory
    fstest.go:247: Filtering empty directory "d"
    fstest.go:247: Filtering empty directory "d/e"
2025/06/22 01:43:57 DEBUG : a/potato2: Need to transfer - File not found at Destination
2025/06/22 01:43:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:43:57 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:43:57 DEBUG : c/non empty space: Unchanged skipping
2025/06/22 01:43:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:44:02 DEBUG : a/potato2: md5 = a4ebb60adf8d729075b83f77a04330c0 OK
2025/06/22 01:44:02 INFO  : a/potato2: Copied (new)
2025/06/22 01:44:02 DEBUG : Waiting for deletions to finish
2025/06/22 01:44:07 INFO  : b/potato: Deleted
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (21.59s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:44:18 DEBUG : b/potato: md5 = 9c315af38f397d31d40c7463c6633602 OK
2025/06/22 01:44:18 DEBUG : c/non empty space: md5 = 77862fe2cab0b3ae89faab26eebfc05a OK
2025/06/22 01:44:18 INFO  : d: Making directory
    fstest.go:247: Filtering empty directory "d"
2025/06/22 01:44:18 DEBUG : a/potato2: Need to transfer - File not found at Destination
2025/06/22 01:44:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:44:18 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:44:18 DEBUG : c/non empty space: Unchanged skipping
2025/06/22 01:44:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:44:23 DEBUG : a/potato2: md5 = 4d81d8329ab498a3de14016242e3b5b9 OK
2025/06/22 01:44:23 INFO  : a/potato2: Copied (new)
2025/06/22 01:44:23 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': not deleting files as there were IO errors
2025/06/22 01:44:28 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': not deleting directories as there were IO errors
    fstest.go:247: Filtering empty directory "d"
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (26.88s)
=== RUN   TestSyncDeleteAfter
--- PASS: TestSyncDeleteAfter (0.00s)
=== RUN   TestSyncDeleteDuring
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:44:45 DEBUG : potato: md5 = 5ce5ced79edc08275b750181e1c8a62b OK
2025/06/22 01:44:45 DEBUG : empty space: md5 = 09c440737f1126882456c4ce7f8b90ab OK
2025/06/22 01:44:45 DEBUG : Waiting for deletions to finish
2025/06/22 01:44:45 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:44:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:44:45 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:44:45 DEBUG : empty space: Unchanged skipping
2025/06/22 01:44:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:44:50 INFO  : potato: Deleted
2025/06/22 01:44:50 DEBUG : potato2: md5 = efafdc590dfb8085d0caaed0caf365f6 OK
2025/06/22 01:44:50 INFO  : potato2: Copied (new)
--- PASS: TestSyncDeleteDuring (21.58s)
=== RUN   TestSyncDeleteBefore
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:45:06 DEBUG : potato: md5 = 9ca5377de2de11abc2d8edb1b24a4bf0 OK
2025/06/22 01:45:06 DEBUG : empty space: md5 = ba38a28ca506bb24dc497385533111a2 OK
2025/06/22 01:45:07 DEBUG : Waiting for deletions to finish
2025/06/22 01:45:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:45:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:45:17 INFO  : potato: Deleted
2025/06/22 01:45:17 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:45:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:45:17 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:45:17 DEBUG : empty space: Unchanged skipping
2025/06/22 01:45:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:45:22 DEBUG : potato2: md5 = a8ff7d8d7fcaeae144ea1517787660ab OK
2025/06/22 01:45:22 INFO  : potato2: Copied (new)
--- PASS: TestSyncDeleteBefore (46.69s)
=== RUN   TestCopyDeleteBefore
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:46:08 DEBUG : potato: md5 = 6e0fa509ed90b5e2172bca9b8a9dffba OK
2025/06/22 01:46:08 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:46:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:46:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:46:28 DEBUG : potato2: md5 = 6405ed4f60d1b7f04433b1aae9f16c91 OK
2025/06/22 01:46:28 INFO  : potato2: Copied (new)
--- PASS: TestCopyDeleteBefore (61.34s)
=== RUN   TestSyncWithExclude
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:46:54 DEBUG : potato2: md5 = dff448ad2ee6c12a47f8987a6cd28cbe OK
2025/06/22 01:46:54 DEBUG : empty space: md5 = d800af09a7e4b419b81dcfb896c0f2b2 OK
2025/06/22 01:46:55 DEBUG : enormous: Excluded (Size Filter)
2025/06/22 01:46:55 DEBUG : enormous: Excluded
2025/06/22 01:46:55 DEBUG : potato2: Excluded (Size Filter)
2025/06/22 01:46:55 DEBUG : potato2: Excluded
2025/06/22 01:46:55 DEBUG : potato2: Excluded (Size Filter)
2025/06/22 01:46:55 DEBUG : potato2: Excluded
2025/06/22 01:46:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:46:55 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:46:55 DEBUG : empty space: Unchanged skipping
2025/06/22 01:46:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:46:55 DEBUG : Waiting for deletions to finish
2025/06/22 01:46:55 INFO  : There was nothing to transfer
2025/06/22 01:47:00 DEBUG : enormous: Excluded (Size Filter)
2025/06/22 01:47:00 DEBUG : enormous: Excluded
2025/06/22 01:47:00 DEBUG : potato2: Excluded (Size Filter)
2025/06/22 01:47:00 DEBUG : potato2: Excluded
2025/06/22 01:47:00 DEBUG : potato2: Excluded (Size Filter)
2025/06/22 01:47:00 DEBUG : potato2: Excluded
2025/06/22 01:47:00 DEBUG : Local file system at /tmp/rclone3055348682: Waiting for checks to finish
2025/06/22 01:47:00 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:47:00 DEBUG : empty space: Unchanged skipping
2025/06/22 01:47:00 DEBUG : Local file system at /tmp/rclone3055348682: Waiting for transfers to finish
2025/06/22 01:47:00 DEBUG : Waiting for deletions to finish
2025/06/22 01:47:00 INFO  : There was nothing to transfer
--- PASS: TestSyncWithExclude (16.53s)
=== RUN   TestSyncWithExcludeAndDeleteExcluded
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:47:11 DEBUG : potato2: md5 = 4c2013c787ed8e8728e398749d9e85b2 OK
2025/06/22 01:47:11 DEBUG : empty space: md5 = 507aa65bb4b7f70e5d8b812f564e44cc OK
2025/06/22 01:47:11 DEBUG : enormous: md5 = 5ffa8ea92fef42b5ade2e5aa75d08709 OK
2025/06/22 01:47:11 DEBUG : enormous: Excluded (Size Filter)
2025/06/22 01:47:11 DEBUG : enormous: Excluded
2025/06/22 01:47:11 DEBUG : potato2: Excluded (Size Filter)
2025/06/22 01:47:11 DEBUG : potato2: Excluded
2025/06/22 01:47:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:47:12 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:47:12 DEBUG : empty space: Unchanged skipping
2025/06/22 01:47:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:47:12 DEBUG : Waiting for deletions to finish
2025/06/22 01:47:12 INFO  : enormous: Deleted
2025/06/22 01:47:17 INFO  : potato2: Deleted
2025/06/22 01:47:17 INFO  : There was nothing to transfer
2025/06/22 01:47:17 DEBUG : Local file system at /tmp/rclone3055348682: Waiting for checks to finish
2025/06/22 01:47:17 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:47:17 DEBUG : empty space: Unchanged skipping
2025/06/22 01:47:17 DEBUG : Local file system at /tmp/rclone3055348682: Waiting for transfers to finish
2025/06/22 01:47:17 DEBUG : Waiting for deletions to finish
2025/06/22 01:47:17 INFO  : enormous: Deleted
2025/06/22 01:47:17 INFO  : potato2: Deleted
2025/06/22 01:47:17 INFO  : There was nothing to transfer
--- PASS: TestSyncWithExcludeAndDeleteExcluded (12.13s)
=== RUN   TestSyncWithUpdateOlder
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:47:18 DEBUG : one: md5 = 0773444d8bbe4ba16b204f28a4d83d22 OK
2025/06/22 01:47:18 DEBUG : two: md5 = 39009c08c97fe03a321034acd4e35756 OK
2025/06/22 01:47:19 DEBUG : three: md5 = 4f1f4680033572e34f0f3515cec66b58 OK
2025/06/22 01:47:24 DEBUG : four: md5 = c4b91ee00932c7606f730e8a1cc5816a OK
2025/06/22 01:47:29 DEBUG : five: Need to transfer - File not found at Destination
2025/06/22 01:47:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:47:29 DEBUG : three: Sizes identical
2025/06/22 01:47:29 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping
2025/06/22 01:47:29 DEBUG : one: Destination is newer than source, skipping
2025/06/22 01:47:30 DEBUG : two: md5 = c70e5aeca7ee26676f836be3a18d1de8 OK
2025/06/22 01:47:30 INFO  : two: Copied (replaced existing)
2025/06/22 01:47:30 DEBUG : five: md5 = 0cd385b9ed57f78f4d27bae32f5dbb01 OK
2025/06/22 01:47:30 INFO  : five: Copied (new)
2025/06/22 01:47:34 DEBUG : four: Sizes differ (src 4 vs dst 8)
2025/06/22 01:47:34 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring
2025/06/22 01:47:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:47:40 DEBUG : four: md5 = 58971237f558874040f41dbb74dd8f88 OK
2025/06/22 01:47:40 INFO  : four: Copied (replaced existing)
2025/06/22 01:47:40 DEBUG : Waiting for deletions to finish
    sync_test.go:1450: Skip test with --checksum as no hashes supported
--- PASS: TestSyncWithUpdateOlder (33.28s)
=== 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-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:1539: Can track renames: false
2025/06/22 01:47:51 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Ignoring --track-renames as the source and destination do not have a common hash
2025/06/22 01:47:51 DEBUG : potato: Need to transfer - File not found at Destination
2025/06/22 01:47:51 DEBUG : yam: Need to transfer - File not found at Destination
2025/06/22 01:47:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:47:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:47:56 DEBUG : potato: md5 = 87f857eb48b1bf590cbd5f20d4eac7a4 OK
2025/06/22 01:47:56 INFO  : potato: Copied (new)
2025/06/22 01:47:57 DEBUG : yam: md5 = 1e650e60c27478cf31175118266bda0c OK
2025/06/22 01:47:57 INFO  : yam: Copied (new)
2025/06/22 01:47:57 DEBUG : Waiting for deletions to finish
2025/06/22 01:47:57 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Ignoring --track-renames as the source and destination do not have a common hash
2025/06/22 01:47:57 DEBUG : yaml: Need to transfer - File not found at Destination
2025/06/22 01:47:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:47:57 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:47:57 DEBUG : potato: Unchanged skipping
2025/06/22 01:47:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:48:02 DEBUG : yaml: md5 = b3b349dbd19b88cc810618396764e7cf OK
2025/06/22 01:48:02 INFO  : yaml: Copied (new)
2025/06/22 01:48:02 DEBUG : Waiting for deletions to finish
2025/06/22 01:48:08 INFO  : yam: Deleted
--- PASS: TestSyncWithTrackRenames (42.30s)
=== RUN   TestParseRenamesStrategyModtime
--- PASS: TestParseRenamesStrategyModtime (0.00s)
=== RUN   TestRenamesStrategyModtime
--- PASS: TestRenamesStrategyModtime (0.00s)
=== RUN   TestSyncWithTrackRenamesStrategyModtime
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:1611: Can track renames: true
2025/06/22 01:48:33 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Making map for --track-renames
2025/06/22 01:48:33 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Finished making map for --track-renames
2025/06/22 01:48:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:48:33 DEBUG : yam: Need to transfer - No matching file found at Destination
2025/06/22 01:48:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for renames to finish
2025/06/22 01:48:33 DEBUG : potato: Need to transfer - No matching file found at Destination
2025/06/22 01:48:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:48:38 DEBUG : potato: md5 = 980b9af21438ea33f1bc5e2f4cda78d2 OK
2025/06/22 01:48:38 INFO  : potato: Copied (new)
2025/06/22 01:48:39 DEBUG : yam: md5 = 2e03b279d4b7c50cfbdd1afdbf8edc53 OK
2025/06/22 01:48:39 INFO  : yam: Copied (new)
2025/06/22 01:48:39 DEBUG : Waiting for deletions to finish
2025/06/22 01:48:44 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Making map for --track-renames
2025/06/22 01:48:44 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Finished making map for --track-renames
2025/06/22 01:48:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:48:44 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:48:44 DEBUG : potato: Unchanged skipping
2025/06/22 01:48:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for renames to finish
2025/06/22 01:49:04 INFO  : yam: Copied (server-side copy) to: yaml
2025/06/22 01:49:09 INFO  : yam: Deleted
2025/06/22 01:49:09 INFO  : yaml: Renamed from "yam"
2025/06/22 01:49:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:49:09 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithTrackRenamesStrategyModtime (51.90s)
=== RUN   TestSyncWithTrackRenamesStrategyLeaf
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:1650: Can track renames: true
2025/06/22 01:49:25 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Making map for --track-renames
2025/06/22 01:49:25 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Finished making map for --track-renames
2025/06/22 01:49:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:49:25 DEBUG : potato: Need to transfer - No matching file found at Destination
2025/06/22 01:49:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for renames to finish
2025/06/22 01:49:25 DEBUG : sub/yam: Need to transfer - No matching file found at Destination
2025/06/22 01:49:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:49:30 DEBUG : potato: md5 = ddf5dde6e0375b0a97d22fa26fb64ffe OK
2025/06/22 01:49:30 INFO  : potato: Copied (new)
2025/06/22 01:49:31 DEBUG : sub/yam: md5 = cf8b95518c1a38d5c4e22e5032514b73 OK
2025/06/22 01:49:31 INFO  : sub/yam: Copied (new)
2025/06/22 01:49:31 DEBUG : Waiting for deletions to finish
2025/06/22 01:49:31 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:49:31 DEBUG : potato: Unchanged skipping
2025/06/22 01:49:31 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Making map for --track-renames
2025/06/22 01:49:31 INFO  : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Finished making map for --track-renames
2025/06/22 01:49:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:49:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for renames to finish
2025/06/22 01:49:46 INFO  : sub/yam: Copied (server-side copy) to: yam
2025/06/22 01:49:52 INFO  : sub/yam: Deleted
2025/06/22 01:49:52 INFO  : yam: Renamed from "sub/yam"
2025/06/22 01:49:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:49:52 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithTrackRenamesStrategyLeaf (42.01s)
=== RUN   TestServerSideMoveLocal
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:50:07 DEBUG : Creating backend with remote "/tmp/rclone3055348682/dir1"
2025/06/22 01:50:07 DEBUG : Config file has changed externally - reloading
2025/06/22 01:50:07 DEBUG : Creating backend with remote "/tmp/rclone3055348682/dir2"
2025/06/22 01:50:07 DEBUG : Local file system at /tmp/rclone3055348682/dir2: Using server-side directory move
2025/06/22 01:50:07 INFO  : Local file system at /tmp/rclone3055348682/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/06/22 01:50:07 DEBUG : file1.txt: Need to transfer - File not found at Destination
2025/06/22 01:50:07 DEBUG : Local file system at /tmp/rclone3055348682/dir2: Waiting for checks to finish
2025/06/22 01:50:07 DEBUG : Local file system at /tmp/rclone3055348682/dir2: Waiting for transfers to finish
2025/06/22 01:50:07 INFO  : file1.txt: Moved (server-side)
--- PASS: TestServerSideMoveLocal (0.30s)
=== RUN   TestMoveWithDeleteEmptySrcDirs
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:50:08 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:50:08 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination
2025/06/22 01:50:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:50:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:50:08 DEBUG : nested/sub dir/file: md5 = b95662e9252410ca823cde82a8e3a860 OK
2025/06/22 01:50:08 INFO  : nested/sub dir/file: Copied (new)
2025/06/22 01:50:08 INFO  : nested/sub dir/file: Deleted
2025/06/22 01:50:13 DEBUG : sub dir/hello world: md5 = 2fb63bbbaade24ec15b4e2f99664c7fd OK
2025/06/22 01:50:13 INFO  : sub dir/hello world: Copied (new)
2025/06/22 01:50:13 INFO  : sub dir/hello world: Deleted
2025/06/22 01:50:13 INFO  : sub dir: Removing directory
2025/06/22 01:50:13 INFO  : nested/sub dir: Removing directory
2025/06/22 01:50:13 INFO  : nested: Removing directory
2025/06/22 01:50:13 DEBUG : Local file system at /tmp/rclone3055348682: deleted 3 directories
--- PASS: TestMoveWithDeleteEmptySrcDirs (15.90s)
=== RUN   TestMoveWithoutDeleteEmptySrcDirs
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:50:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/22 01:50:23 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination
2025/06/22 01:50:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:50:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:50:24 DEBUG : nested/sub dir/file: md5 = 07bc68e898b54eb2cad20e753e9d474c OK
2025/06/22 01:50:24 INFO  : nested/sub dir/file: Copied (new)
2025/06/22 01:50:24 INFO  : nested/sub dir/file: Deleted
2025/06/22 01:50:29 DEBUG : sub dir/hello world: md5 = 700d5ac8c36a47298a11b0c946b50347 OK
2025/06/22 01:50:29 INFO  : sub dir/hello world: Copied (new)
2025/06/22 01:50:29 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveWithoutDeleteEmptySrcDirs (16.20s)
=== RUN   TestMoveWithIgnoreExisting
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:50:40 DEBUG : existing-b: Need to transfer - File not found at Destination
2025/06/22 01:50:40 DEBUG : existing: Need to transfer - File not found at Destination
2025/06/22 01:50:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:50:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:50:45 DEBUG : existing: md5 = 147be52ddcc9af3aa1cb2cb449608464 OK
2025/06/22 01:50:45 INFO  : existing: Copied (new)
2025/06/22 01:50:45 INFO  : existing: Deleted
2025/06/22 01:50:45 DEBUG : existing-b: md5 = ee9261a0e1d4411343d6746d512e4804 OK
2025/06/22 01:50:45 INFO  : existing-b: Copied (new)
2025/06/22 01:50:45 INFO  : existing-b: Deleted
2025/06/22 01:51:05 DEBUG : existing: Destination exists, skipping
2025/06/22 01:51:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 01:51:05 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set
2025/06/22 01:51:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 01:51:05 INFO  : There was nothing to transfer
--- PASS: TestMoveWithIgnoreExisting (126.44s)
=== RUN   TestServerSideMove
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:52:46 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bopidac7meqo"
2025/06/22 01:52:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bopidac7meqo.bin"
2025/06/22 01:52:46 DEBUG : Swift container crypt path rclone-test-bopidac7meqo.bin: Auto set use_segments_container to true
2025/06/22 01:53:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bopidac7meqo"
2025/06/22 01:53:07 DEBUG : Swift container crypt path rclone-test-bopidac7meqo: Auto set use_segments_container to true
2025/06/22 01:53:18 DEBUG : potato2: md5 = 34aa768bfe2ef3982afa79cd4f751236 OK
2025/06/22 01:53:18 DEBUG : empty space: md5 = 0d7a77775a686cb9a8c9d882ed54de56 OK
2025/06/22 01:53:18 DEBUG : potato3: md5 = 66c92fdff0fdc7a1acd52a301bff67bd OK
    sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi' -> Encrypted drive 'TestCryptSwift:rclone-test-bopidac7meqo'
2025/06/22 01:53:29 DEBUG : empty space: md5 = 4e3f41d7711adee53efd64fefd51f43c OK
2025/06/22 01:53:29 DEBUG : potato3: md5 = a3399f057112486ccd06385a1e18cf32 OK
2025/06/22 01:53:30 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:53:30 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2025/06/22 01:53:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bopidac7meqo': Waiting for checks to finish
2025/06/22 01:53:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:53:35 DEBUG : empty space: Unchanged skipping
2025/06/22 01:53:35 INFO  : empty space: Deleted
2025/06/22 01:53:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bopidac7meqo': Waiting for transfers to finish
2025/06/22 01:53:38 INFO  : potato3: Copied (server-side copy)
2025/06/22 01:53:38 INFO  : potato3: Deleted
2025/06/22 01:53:50 INFO  : potato2: Copied (server-side copy)
2025/06/22 01:54:10 INFO  : potato2: Deleted
2025/06/22 01:54:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gutidov6haxi"
2025/06/22 01:54:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gutidov6haxi.bin"
2025/06/22 01:54:16 DEBUG : Swift container crypt path rclone-test-gutidov6haxi.bin: Auto set use_segments_container to true
2025/06/22 01:54:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gutidov6haxi"
2025/06/22 01:54:37 DEBUG : Swift container crypt path rclone-test-gutidov6haxi: Auto set use_segments_container to true
2025/06/22 01:54:42 DEBUG : empty space: Need to transfer - File not found at Destination
2025/06/22 01:54:42 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:54:42 DEBUG : potato3: Need to transfer - File not found at Destination
2025/06/22 01:54:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gutidov6haxi': Waiting for checks to finish
2025/06/22 01:54:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gutidov6haxi': Waiting for transfers to finish
2025/06/22 01:54:48 INFO  : empty space: Copied (server-side copy)
2025/06/22 01:54:53 INFO  : empty space: Deleted
2025/06/22 01:54:56 INFO  : potato3: Copied (server-side copy)
2025/06/22 01:54:56 INFO  : potato3: Deleted
2025/06/22 01:54:58 INFO  : potato2: Copied (server-side copy)
2025/06/22 01:55:03 INFO  : potato2: Deleted
2025/06/22 01:55:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gutidov6haxi': Purge remote
2025/06/22 01:55:03 DEBUG : Waiting for deletions to finish
2025/06/22 01:55:03 INFO  : empty space.bin: Deleted
2025/06/22 01:55:13 INFO  : potato2.bin: Deleted
2025/06/22 01:55:13 INFO  : potato3.bin: Deleted
2025/06/22 01:55:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bopidac7meqo': Purge remote
2025/06/22 01:55:13 DEBUG : Waiting for deletions to finish
--- PASS: TestServerSideMove (147.78s)
=== RUN   TestServerSideMoveWithFilter
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:55:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qitozag6rogo"
2025/06/22 01:55:14 DEBUG : Config file has changed externally - reloading
2025/06/22 01:55:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qitozag6rogo.bin"
2025/06/22 01:55:14 DEBUG : Swift container crypt path rclone-test-qitozag6rogo.bin: Auto set use_segments_container to true
2025/06/22 01:55:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qitozag6rogo"
2025/06/22 01:55:20 DEBUG : Swift container crypt path rclone-test-qitozag6rogo: Auto set use_segments_container to true
2025/06/22 01:55:30 DEBUG : potato2: md5 = 37e6474e26887e742c84869ff0131588 OK
2025/06/22 01:55:30 DEBUG : empty space: md5 = 6ba8fe7607299734a4c9a68fbefc6b1a OK
2025/06/22 01:55:31 DEBUG : potato3: md5 = cec1f2db7ee6b62e053dbf96bd3a6f52 OK
    sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi' -> Encrypted drive 'TestCryptSwift:rclone-test-qitozag6rogo'
2025/06/22 01:55:32 DEBUG : empty space: md5 = f584558c6ba7ec7b431c6e56f1d3ae79 OK
2025/06/22 01:55:53 DEBUG : potato3: md5 = 51904e72c4cf17ddb04ded8d197cf6d0 OK
2025/06/22 01:56:13 DEBUG : empty space: Excluded (Size Filter)
2025/06/22 01:56:13 DEBUG : empty space: Excluded
2025/06/22 01:56:13 DEBUG : empty space: Excluded (Size Filter)
2025/06/22 01:56:13 DEBUG : empty space: Excluded
2025/06/22 01:56:13 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:56:13 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2025/06/22 01:56:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qitozag6rogo': Waiting for checks to finish
2025/06/22 01:56:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qitozag6rogo': Waiting for transfers to finish
2025/06/22 01:56:34 INFO  : potato2: Copied (server-side copy)
2025/06/22 01:56:54 INFO  : potato2: Deleted
2025/06/22 01:57:14 INFO  : potato3: Copied (server-side copy)
2025/06/22 01:57:14 INFO  : potato3: Deleted
2025/06/22 01:57:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bekihep9fito"
2025/06/22 01:57:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bekihep9fito.bin"
2025/06/22 01:57:15 DEBUG : Swift container crypt path rclone-test-bekihep9fito.bin: Auto set use_segments_container to true
2025/06/22 01:57:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bekihep9fito"
2025/06/22 01:57:20 DEBUG : Swift container crypt path rclone-test-bekihep9fito: Auto set use_segments_container to true
2025/06/22 01:57:26 DEBUG : empty space: Excluded (Size Filter)
2025/06/22 01:57:26 DEBUG : empty space: Excluded
2025/06/22 01:57:26 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:57:26 DEBUG : potato3: Need to transfer - File not found at Destination
2025/06/22 01:57:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bekihep9fito': Waiting for checks to finish
2025/06/22 01:57:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bekihep9fito': Waiting for transfers to finish
2025/06/22 01:57:31 INFO  : potato3: Copied (server-side copy)
2025/06/22 01:57:36 INFO  : potato2: Copied (server-side copy)
2025/06/22 01:57:36 INFO  : potato2: Deleted
2025/06/22 01:57:36 INFO  : potato3: Deleted
2025/06/22 01:57:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bekihep9fito': Purge remote
2025/06/22 01:57:37 DEBUG : Waiting for deletions to finish
2025/06/22 01:57:37 INFO  : potato3.bin: Deleted
2025/06/22 01:57:42 INFO  : potato2.bin: Deleted
2025/06/22 01:57:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qitozag6rogo': Purge remote
2025/06/22 01:57:42 DEBUG : Waiting for deletions to finish
2025/06/22 01:57:43 INFO  : empty space.bin: Deleted
--- PASS: TestServerSideMoveWithFilter (149.42s)
=== RUN   TestServerSideMoveDeleteEmptySourceDirs
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:57:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-faqidiy6tera"
2025/06/22 01:57:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-faqidiy6tera.bin"
2025/06/22 01:57:44 DEBUG : Swift container crypt path rclone-test-faqidiy6tera.bin: Auto set use_segments_container to true
2025/06/22 01:57:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-faqidiy6tera"
2025/06/22 01:57:49 DEBUG : Swift container crypt path rclone-test-faqidiy6tera: Auto set use_segments_container to true
2025/06/22 01:58:15 DEBUG : potato2: md5 = 0d9fae6f9a010c12f1c8555773cf25e0 OK
2025/06/22 01:58:15 DEBUG : empty space: md5 = 1cf24760e379336fecc1f33d6d295a3e OK
2025/06/22 01:58:15 DEBUG : potato3: md5 = 7c3354342c375dfcaa1a8b36844da3b8 OK
2025/06/22 01:58:15 INFO  : tomatoDir: Making directory
    sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi' -> Encrypted drive 'TestCryptSwift:rclone-test-faqidiy6tera'
2025/06/22 01:58:26 DEBUG : empty space: md5 = d4fda8f16a38606d88c9992fd180d390 OK
2025/06/22 01:58:31 DEBUG : potato3: md5 = 96cb1619585bbc02463737f6ca287fe6 OK
2025/06/22 01:58:36 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:58:36 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2025/06/22 01:58:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-faqidiy6tera': Waiting for checks to finish
2025/06/22 01:58:36 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 01:58:36 DEBUG : empty space: Unchanged skipping
2025/06/22 01:58:37 INFO  : empty space: Deleted
2025/06/22 01:58:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-faqidiy6tera': Waiting for transfers to finish
2025/06/22 01:58:42 INFO  : potato2: Copied (server-side copy)
2025/06/22 01:58:47 INFO  : potato3: Copied (server-side copy)
2025/06/22 01:58:47 INFO  : potato3: Deleted
2025/06/22 01:58:47 INFO  : potato2: Deleted
2025/06/22 01:58:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-ramozit8geko"
2025/06/22 01:58:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-ramozit8geko.bin"
2025/06/22 01:58:58 DEBUG : Swift container crypt path rclone-test-ramozit8geko.bin: Auto set use_segments_container to true
2025/06/22 01:59:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-ramozit8geko"
2025/06/22 01:59:04 DEBUG : Swift container crypt path rclone-test-ramozit8geko: Auto set use_segments_container to true
2025/06/22 01:59:09 INFO  : tomatoDir: Making directory
2025/06/22 01:59:09 DEBUG : empty space: Need to transfer - File not found at Destination
2025/06/22 01:59:09 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/22 01:59:09 DEBUG : potato3: Need to transfer - File not found at Destination
2025/06/22 01:59:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-ramozit8geko': Waiting for checks to finish
2025/06/22 01:59:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-ramozit8geko': Waiting for transfers to finish
2025/06/22 01:59:25 INFO  : potato2: Copied (server-side copy)
2025/06/22 01:59:25 INFO  : potato2: Deleted
2025/06/22 01:59:25 INFO  : potato3: Copied (server-side copy)
2025/06/22 01:59:29 INFO  : empty space: Copied (server-side copy)
2025/06/22 01:59:30 INFO  : potato3: Deleted
2025/06/22 01:59:35 INFO  : empty space: Deleted
2025/06/22 01:59:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-ramozit8geko': Purge remote
2025/06/22 01:59:40 DEBUG : Waiting for deletions to finish
2025/06/22 01:59:45 INFO  : potato3.bin: Deleted
2025/06/22 01:59:45 INFO  : empty space.bin: Deleted
2025/06/22 01:59:45 INFO  : potato2.bin: Deleted
2025/06/22 01:59:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-faqidiy6tera': Purge remote
2025/06/22 01:59:45 DEBUG : Waiting for deletions to finish
--- PASS: TestServerSideMoveDeleteEmptySourceDirs (122.58s)
=== RUN   TestServerSideMoveOverlap
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 01:59:46 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/rclone-move-test"
2025/06/22 01:59:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-move-test.bin"
2025/06/22 01:59:46 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-move-test.bin: Auto set use_segments_container to true
2025/06/22 01:59:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-move-test"
2025/06/22 01:59:52 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-move-test: Auto set use_segments_container to true
2025/06/22 02:00:02 DEBUG : potato2: md5 = 7c592fc1211d18f92b7ab20e7251ebbd OK
--- PASS: TestServerSideMoveOverlap (27.35s)
=== RUN   TestSyncOverlap
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:00:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test"
2025/06/22 02:00:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-sync-test.bin"
2025/06/22 02:00:14 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-sync-test.bin: Auto set use_segments_container to true
2025/06/22 02:00:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-sync-test"
2025/06/22 02:00:19 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-sync-test: Auto set use_segments_container to true
--- PASS: TestSyncOverlap (11.80s)
=== RUN   TestSyncOverlapWithFilter
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:00:25 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test"
2025/06/22 02:00:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-sync-test.bin"
2025/06/22 02:00:25 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-sync-test.bin: Auto set use_segments_container to true
2025/06/22 02:00:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-sync-test"
2025/06/22 02:00:31 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-sync-test: Auto set use_segments_container to true
2025/06/22 02:00:36 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test-include/layer2"
2025/06/22 02:00:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-sync-test-include/layer2.bin"
2025/06/22 02:00:36 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true
2025/06/22 02:00:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-sync-test-include/layer2"
2025/06/22 02:00:42 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-sync-test-include/layer2: Auto set use_segments_container to true
2025/06/22 02:00:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test-ignore-file"
2025/06/22 02:00:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-sync-test-ignore-file.bin"
2025/06/22 02:00:48 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true
2025/06/22 02:00:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/rclone-sync-test-ignore-file"
2025/06/22 02:00:53 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/rclone-sync-test-ignore-file: Auto set use_segments_container to true
2025/06/22 02:00:59 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = 1bc8c06a9d38defb87e5c2d3f7d64b79 OK
2025/06/22 02:01:05 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/22 02:01:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test': Waiting for checks to finish
2025/06/22 02:01:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test': Waiting for transfers to finish
2025/06/22 02:01:05 DEBUG : Waiting for deletions to finish
2025/06/22 02:01:05 INFO  : There was nothing to transfer
2025/06/22 02:01:10 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/22 02:01:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 02:01:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 02:01:10 DEBUG : Waiting for deletions to finish
2025/06/22 02:01:10 INFO  : There was nothing to transfer
2025/06/22 02:01:15 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/22 02:01:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test-include/layer2': Waiting for checks to finish
2025/06/22 02:01:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test-include/layer2': Waiting for transfers to finish
2025/06/22 02:01:15 DEBUG : Waiting for deletions to finish
2025/06/22 02:01:15 INFO  : There was nothing to transfer
2025/06/22 02:01:21 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/22 02:01:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 02:01:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 02:01:21 DEBUG : Waiting for deletions to finish
2025/06/22 02:01:21 INFO  : There was nothing to transfer
2025/06/22 02:01:21 DEBUG : Excluded
2025/06/22 02:01:21 DEBUG : rclone-sync-test-ignore-file: Excluded
2025/06/22 02:01:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test-ignore-file': Waiting for checks to finish
2025/06/22 02:01:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/rclone-sync-test-ignore-file': Waiting for transfers to finish
2025/06/22 02:01:21 DEBUG : Waiting for deletions to finish
2025/06/22 02:01:21 INFO  : There was nothing to transfer
--- PASS: TestSyncOverlapWithFilter (56.07s)
=== RUN   TestSyncCompareDest
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:01:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/dst"
2025/06/22 02:01:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst.bin"
2025/06/22 02:01:21 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst.bin: Auto set use_segments_container to true
2025/06/22 02:01:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst"
2025/06/22 02:01:27 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst: Auto set use_segments_container to true
2025/06/22 02:01:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/CompareDest"
2025/06/22 02:01:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/CompareDest.bin"
2025/06/22 02:01:33 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/CompareDest.bin: Auto set use_segments_container to true
2025/06/22 02:01:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/CompareDest"
2025/06/22 02:01:38 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/CompareDest: Auto set use_segments_container to true
2025/06/22 02:01:49 DEBUG : one: Need to transfer - File not found at Destination
2025/06/22 02:01:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:01:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:01:55 DEBUG : one: md5 = 701b16c2855eb23eb9be8cf0cf239230 OK
2025/06/22 02:01:55 INFO  : one: Copied (new)
2025/06/22 02:01:55 DEBUG : Waiting for deletions to finish
2025/06/22 02:02:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:02:00 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/22 02:02:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:02:16 DEBUG : one: md5 = 5cbce8260a5c03a3c54e7333ea94de7f OK
2025/06/22 02:02:16 INFO  : one: Copied (replaced existing)
2025/06/22 02:02:16 DEBUG : Waiting for deletions to finish
2025/06/22 02:02:21 DEBUG : dst/one: md5 = 8b26763206fa20133d3d91cb9ed72d43 OK
2025/06/22 02:02:26 DEBUG : CompareDest/one: md5 = dfc26cae0e1a9888af73936ae8d46464 OK
2025/06/22 02:02:26 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/22 02:02:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:02:32 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:02:32 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/22 02:02:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:02:32 DEBUG : Waiting for deletions to finish
2025/06/22 02:02:32 INFO  : There was nothing to transfer
2025/06/22 02:02:37 DEBUG : CompareDest/two: md5 = 6dc46508125f2353caaf282ffc93a518 OK
2025/06/22 02:02:38 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/22 02:02:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:02:38 DEBUG : two: Destination found in --compare-dest, skipping
2025/06/22 02:02:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:02:38 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:02:38 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/22 02:02:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:02:38 DEBUG : Waiting for deletions to finish
2025/06/22 02:02:38 INFO  : There was nothing to transfer
2025/06/22 02:02:38 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/22 02:02:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:02:38 DEBUG : two: Destination found in --compare-dest, skipping
2025/06/22 02:02:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:02:38 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:02:38 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/22 02:02:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:02:38 DEBUG : Waiting for deletions to finish
2025/06/22 02:02:38 INFO  : There was nothing to transfer
    sync_test.go:2176: No hash on uploaded file so skipping compare timestamp test
2025/06/22 02:02:44 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/22 02:02:44 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:02:44 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/22 02:02:44 DEBUG : two: Sizes differ (src 5 vs dst 3)
2025/06/22 02:02:44 DEBUG : two: Need to transfer - File not found at Destination
2025/06/22 02:02:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:02:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:02:49 DEBUG : two: md5 = 66f109ce01075f94ec8a3b8724ea9092 OK
2025/06/22 02:02:49 INFO  : two: Copied (new)
2025/06/22 02:02:49 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCompareDest (113.95s)
=== RUN   TestSyncMultipleCompareDest
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:03:20 DEBUG : pre-dest1/1: md5 = 0383ef05fc5a4413e9e98fe982af7149 OK
2025/06/22 02:03:21 DEBUG : pre-dest2/2: md5 = abe434a12a94afd091870afb93e8b8b6 OK
2025/06/22 02:03:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/dest"
2025/06/22 02:03:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dest.bin"
2025/06/22 02:03:26 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dest.bin: Auto set use_segments_container to true
2025/06/22 02:03:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dest"
2025/06/22 02:03:32 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dest: Auto set use_segments_container to true
2025/06/22 02:03:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/pre-dest1"
2025/06/22 02:03:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/pre-dest1.bin"
2025/06/22 02:03:38 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/pre-dest1.bin: Auto set use_segments_container to true
2025/06/22 02:03:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/pre-dest1"
2025/06/22 02:03:43 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/pre-dest1: Auto set use_segments_container to true
2025/06/22 02:03:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/pre-dest2"
2025/06/22 02:03:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/pre-dest2.bin"
2025/06/22 02:03:49 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/pre-dest2.bin: Auto set use_segments_container to true
2025/06/22 02:03:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/pre-dest2"
2025/06/22 02:03:54 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/pre-dest2: Auto set use_segments_container to true
2025/06/22 02:04:00 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:04:00 DEBUG : 1: Destination found in --compare-dest, skipping
2025/06/22 02:04:05 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:04:05 DEBUG : 2: Destination found in --compare-dest, skipping
2025/06/22 02:04:16 DEBUG : 3: Need to transfer - File not found at Destination
2025/06/22 02:04:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dest': Waiting for checks to finish
2025/06/22 02:04:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dest': Waiting for transfers to finish
2025/06/22 02:04:21 DEBUG : 3: md5 = 803861aa040cd27248f0ec060717d0b3 OK
2025/06/22 02:04:21 INFO  : 3: Copied (new)
2025/06/22 02:04:21 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncMultipleCompareDest (86.98s)
=== RUN   TestSyncCopyDest
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:04:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/dst"
2025/06/22 02:04:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst.bin"
2025/06/22 02:04:42 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst.bin: Auto set use_segments_container to true
2025/06/22 02:04:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst"
2025/06/22 02:04:48 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst: Auto set use_segments_container to true
2025/06/22 02:04:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/CopyDest"
2025/06/22 02:04:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/CopyDest.bin"
2025/06/22 02:04:53 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/CopyDest.bin: Auto set use_segments_container to true
2025/06/22 02:04:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/CopyDest"
2025/06/22 02:04:59 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/CopyDest: Auto set use_segments_container to true
2025/06/22 02:05:10 DEBUG : one: Need to transfer - File not found at Destination
2025/06/22 02:05:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:05:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:05:15 DEBUG : one: md5 = 6d41bea22ff4f20a94cb71722512e47c OK
2025/06/22 02:05:15 INFO  : one: Copied (new)
2025/06/22 02:05:15 DEBUG : Waiting for deletions to finish
2025/06/22 02:05:26 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/22 02:05:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:05:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:05:41 DEBUG : one: md5 = 7db2ba99a286f45dde6c523ccf4fe584 OK
2025/06/22 02:05:41 INFO  : one: Copied (replaced existing)
2025/06/22 02:05:41 DEBUG : Waiting for deletions to finish
2025/06/22 02:05:46 DEBUG : dst/one: md5 = 062a920bd857e78ebcc3d01af6b39e2b OK
2025/06/22 02:05:51 DEBUG : CopyDest/one: md5 = 42a810ddfefe9d22984b3be1a60cbf3c OK
2025/06/22 02:05:57 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/BackupDir"
2025/06/22 02:05:57 DEBUG : Config file has changed externally - reloading
2025/06/22 02:05:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/BackupDir.bin"
2025/06/22 02:05:57 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/BackupDir.bin: Auto set use_segments_container to true
2025/06/22 02:06:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/BackupDir"
2025/06/22 02:06:03 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/BackupDir: Auto set use_segments_container to true
2025/06/22 02:06:09 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/22 02:06:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:06:14 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:06:14 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/22 02:06:29 INFO  : one: Copied (server-side copy)
2025/06/22 02:06:34 INFO  : one: Deleted
2025/06/22 02:06:50 INFO  : one: Copied (server-side copy)
2025/06/22 02:06:50 DEBUG : one: Destination found in --copy-dest, using server-side copy
2025/06/22 02:06:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:06:50 DEBUG : Waiting for deletions to finish
2025/06/22 02:06:56 DEBUG : CopyDest/two: md5 = d6b3d509d0f20de96bfb03b7b1a896cf OK
2025/06/22 02:06:56 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:06:56 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:06:56 DEBUG : one: Unchanged skipping
2025/06/22 02:07:06 INFO  : two: Copied (server-side copy)
2025/06/22 02:07:06 DEBUG : two: Destination found in --copy-dest, using server-side copy
2025/06/22 02:07:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:07:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:07:06 DEBUG : Waiting for deletions to finish
2025/06/22 02:07:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:07:07 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:07:07 DEBUG : one: Unchanged skipping
2025/06/22 02:07:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:07:07 DEBUG : two: Unchanged skipping
2025/06/22 02:07:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:07:07 DEBUG : Waiting for deletions to finish
2025/06/22 02:07:07 INFO  : There was nothing to transfer
2025/06/22 02:07:13 DEBUG : CopyDest/three: md5 = af70afc3bd0add8abfffad850ec68adb OK
2025/06/22 02:07:13 DEBUG : three: Sizes differ (src 7 vs dst 5)
2025/06/22 02:07:13 DEBUG : three: Destination not found in --copy-dest
2025/06/22 02:07:13 DEBUG : three: Need to transfer - File not found at Destination
2025/06/22 02:07:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:07:13 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:07:13 DEBUG : two: Unchanged skipping
2025/06/22 02:07:18 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:07:18 DEBUG : one: Unchanged skipping
2025/06/22 02:07:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:07:18 DEBUG : three: md5 = 2ec9cd01f616a677af0ef35edacf43d9 OK
2025/06/22 02:07:18 INFO  : three: Copied (new)
2025/06/22 02:07:18 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCopyDest (193.39s)
=== RUN   TestSyncBackupDir
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:08:01 DEBUG : dst/one: md5 = 48fa9184d6b0cabab72bd95de5816171 OK
2025/06/22 02:08:06 DEBUG : dst/two: md5 = 7ae6a59e1ca355e66249eb59be522381 OK
2025/06/22 02:08:11 DEBUG : dst/three.txt: md5 = 06d4fb87f183a11fca1d15b77545eb70 OK
2025/06/22 02:08:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/dst"
2025/06/22 02:08:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst.bin"
2025/06/22 02:08:22 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst.bin: Auto set use_segments_container to true
2025/06/22 02:08:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst"
2025/06/22 02:08:27 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst: Auto set use_segments_container to true
2025/06/22 02:08:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/backup"
2025/06/22 02:08:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/backup.bin"
2025/06/22 02:08:33 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/backup.bin: Auto set use_segments_container to true
2025/06/22 02:08:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/backup"
2025/06/22 02:08:38 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/backup: Auto set use_segments_container to true
2025/06/22 02:08:44 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/22 02:08:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:08:44 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:08:44 DEBUG : two: Unchanged skipping
2025/06/22 02:09:00 INFO  : one: Copied (server-side copy)
2025/06/22 02:09:05 INFO  : one: Deleted
2025/06/22 02:09:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:09:10 DEBUG : one: md5 = 21f166a776fa249acbfcfb98f14813c6 OK
2025/06/22 02:09:10 INFO  : one: Copied (new)
2025/06/22 02:09:10 DEBUG : Waiting for deletions to finish
2025/06/22 02:09:36 INFO  : three.txt: Copied (server-side copy)
2025/06/22 02:09:41 INFO  : three.txt: Deleted
2025/06/22 02:09:41 INFO  : three.txt: Moved into backup dir
2025/06/22 02:09:52 DEBUG : dst/three.txt: md5 = 0a5f28fdce9380ee2e6eaec1136d6c09 OK
2025/06/22 02:09:57 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/22 02:09:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:09:57 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:09:57 DEBUG : two: Unchanged skipping
2025/06/22 02:10:03 INFO  : one: Copied (server-side copy)
2025/06/22 02:10:08 INFO  : one: Deleted
2025/06/22 02:10:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:10:13 DEBUG : one: md5 = 74bf378316299981b11f9d8b1de1a6ed OK
2025/06/22 02:10:13 INFO  : one: Copied (new)
2025/06/22 02:10:13 DEBUG : Waiting for deletions to finish
2025/06/22 02:10:28 INFO  : three.txt: Copied (server-side copy)
2025/06/22 02:10:33 INFO  : three.txt: Deleted
2025/06/22 02:10:33 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDir (184.15s)
=== RUN   TestSyncBackupDirWithSuffix
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:11:05 DEBUG : dst/one: md5 = 478e7bb31900a10bf3695e3df5690936 OK
2025/06/22 02:11:10 DEBUG : dst/two: md5 = ac317a22577f1b088d73be685fb03e56 OK
2025/06/22 02:11:15 DEBUG : dst/three.txt: md5 = b2f24cdb93c5e553503630dd2051a982 OK
2025/06/22 02:11:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/dst"
2025/06/22 02:11:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst.bin"
2025/06/22 02:11:16 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst.bin: Auto set use_segments_container to true
2025/06/22 02:11:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst"
2025/06/22 02:11:21 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst: Auto set use_segments_container to true
2025/06/22 02:11:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/backup"
2025/06/22 02:11:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/backup.bin"
2025/06/22 02:11:27 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/backup.bin: Auto set use_segments_container to true
2025/06/22 02:11:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/backup"
2025/06/22 02:11:32 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/backup: Auto set use_segments_container to true
2025/06/22 02:11:37 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/22 02:11:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:11:42 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:11:42 DEBUG : two: Unchanged skipping
2025/06/22 02:11:53 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/22 02:11:58 INFO  : one: Deleted
2025/06/22 02:11:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:12:04 DEBUG : one: md5 = e8ce54ffe6e67bb7302724568b417e90 OK
2025/06/22 02:12:04 INFO  : one: Copied (new)
2025/06/22 02:12:04 DEBUG : Waiting for deletions to finish
2025/06/22 02:12:24 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/22 02:12:29 INFO  : three.txt: Deleted
2025/06/22 02:12:29 INFO  : three.txt: Moved into backup dir
2025/06/22 02:12:45 DEBUG : dst/three.txt: md5 = ff857364457790ae46d7c150c6d9e67c OK
2025/06/22 02:13:00 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/22 02:13:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:13:05 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:13:05 DEBUG : two: Unchanged skipping
2025/06/22 02:13:06 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/22 02:13:11 INFO  : one: Deleted
2025/06/22 02:13:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:13:17 DEBUG : one: md5 = a2e0471dbe875abd96ed3b24a71ca932 OK
2025/06/22 02:13:17 INFO  : one: Copied (new)
2025/06/22 02:13:17 DEBUG : Waiting for deletions to finish
2025/06/22 02:13:42 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/22 02:13:47 INFO  : three.txt: Deleted
2025/06/22 02:13:47 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffix (193.79s)
=== RUN   TestSyncBackupDirWithSuffixKeepExtension
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:14:19 DEBUG : dst/one: md5 = 9f0af4e704ca769b899cf410b886ed48 OK
2025/06/22 02:14:24 DEBUG : dst/two: md5 = e251015b7fab28f4281fbcd4a8f3416f OK
2025/06/22 02:14:29 DEBUG : dst/three.txt: md5 = ec5591da7981b6d44d0ed13fb1d8e4d6 OK
2025/06/22 02:14:34 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/dst"
2025/06/22 02:14:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst.bin"
2025/06/22 02:14:34 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst.bin: Auto set use_segments_container to true
2025/06/22 02:14:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst"
2025/06/22 02:14:40 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst: Auto set use_segments_container to true
2025/06/22 02:14:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/backup"
2025/06/22 02:14:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/backup.bin"
2025/06/22 02:14:46 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/backup.bin: Auto set use_segments_container to true
2025/06/22 02:14:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/backup"
2025/06/22 02:14:51 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/backup: Auto set use_segments_container to true
2025/06/22 02:14:56 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/22 02:14:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:14:56 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:14:56 DEBUG : two: Unchanged skipping
2025/06/22 02:15:07 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2025/06/22 02:15:12 INFO  : one: Deleted
2025/06/22 02:15:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:15:18 DEBUG : one: md5 = 251b17c28602da05e05eaf8bbf5dabbe OK
2025/06/22 02:15:18 INFO  : one: Copied (new)
2025/06/22 02:15:18 DEBUG : Waiting for deletions to finish
2025/06/22 02:15:33 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2025/06/22 02:15:38 INFO  : three.txt: Deleted
2025/06/22 02:15:38 INFO  : three.txt: Moved into backup dir
2025/06/22 02:15:59 DEBUG : dst/three.txt: md5 = d7ad537147857aba845a1c3e9c4297aa OK
2025/06/22 02:16:04 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/22 02:16:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:16:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:16:04 DEBUG : two: Unchanged skipping
2025/06/22 02:16:09 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2025/06/22 02:16:14 INFO  : one: Deleted
2025/06/22 02:16:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:16:20 DEBUG : one: md5 = 5a744bd700352a63f5f5083eac801cb2 OK
2025/06/22 02:16:20 INFO  : one: Copied (new)
2025/06/22 02:16:20 DEBUG : Waiting for deletions to finish
2025/06/22 02:16:45 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2025/06/22 02:16:50 INFO  : three.txt: Deleted
2025/06/22 02:16:50 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffixKeepExtension (188.27s)
=== RUN   TestSyncBackupDirSuffixOnly
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:17:27 DEBUG : dst/one: md5 = c4d69e0a319d69279ee9b6a655c39614 OK
2025/06/22 02:17:32 DEBUG : dst/two: md5 = 2e07f625eec82d296bf0933aa42550fa OK
2025/06/22 02:17:37 DEBUG : dst/three.txt: md5 = 652f9530c65ba27db074bab4e98244ef OK
2025/06/22 02:17:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/dst"
2025/06/22 02:17:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst.bin"
2025/06/22 02:17:43 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst.bin: Auto set use_segments_container to true
2025/06/22 02:17:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst"
2025/06/22 02:17:48 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst: Auto set use_segments_container to true
2025/06/22 02:17:54 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/22 02:17:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:17:54 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:17:54 DEBUG : two: Unchanged skipping
2025/06/22 02:18:04 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/22 02:18:10 INFO  : one: Deleted
2025/06/22 02:18:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:18:15 DEBUG : one: md5 = 469eaf48159d6a8d3559c0a7709347e1 OK
2025/06/22 02:18:15 INFO  : one: Copied (new)
2025/06/22 02:18:15 DEBUG : Waiting for deletions to finish
2025/06/22 02:18:36 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/22 02:18:41 INFO  : three.txt: Deleted
2025/06/22 02:18:41 INFO  : three.txt: Moved into backup dir
2025/06/22 02:18:46 DEBUG : dst/three.txt: md5 = 10551e0e5624e832ea78469744aa454e OK
2025/06/22 02:18:57 DEBUG : one.bak: Excluded (Path Filter)
2025/06/22 02:18:57 DEBUG : one.bak: Excluded
2025/06/22 02:18:57 DEBUG : three.txt.bak: Excluded (Path Filter)
2025/06/22 02:18:57 DEBUG : three.txt.bak: Excluded
2025/06/22 02:18:57 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/22 02:18:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for checks to finish
2025/06/22 02:19:02 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:19:02 DEBUG : two: Unchanged skipping
2025/06/22 02:19:02 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/22 02:19:07 INFO  : one: Deleted
2025/06/22 02:19:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi/dst': Waiting for transfers to finish
2025/06/22 02:19:12 DEBUG : one: md5 = 49624d19778bd7d8a3dabe35fa71ab43 OK
2025/06/22 02:19:12 INFO  : one: Copied (new)
2025/06/22 02:19:12 DEBUG : Waiting for deletions to finish
2025/06/22 02:19:33 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/22 02:19:38 INFO  : three.txt: Deleted
2025/06/22 02:19:38 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirSuffixOnly (167.60s)
=== RUN   TestSyncSuffix
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:20:15 DEBUG : dst/one: md5 = 055dcae4fd2b036d225ac1a7ac2fb2a3 OK
2025/06/22 02:20:20 DEBUG : dst/two: md5 = 080764de94ab368a66beb45efaaaa83e OK
2025/06/22 02:20:25 DEBUG : dst/three.txt: md5 = b73ff9489a7df9241aca252b4d0baa0f OK
2025/06/22 02:20:25 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/dst"
2025/06/22 02:20:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst.bin"
2025/06/22 02:20:26 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst.bin: Auto set use_segments_container to true
2025/06/22 02:20:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst"
2025/06/22 02:20:31 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst: Auto set use_segments_container to true
2025/06/22 02:20:36 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/22 02:20:47 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/22 02:20:52 INFO  : one: Deleted
2025/06/22 02:20:57 DEBUG : one: md5 = 925f019a1cb160b1ea6e228d54f7f5c1 OK
2025/06/22 02:20:57 INFO  : one: Copied (new)
2025/06/22 02:20:57 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:20:57 DEBUG : two: Unchanged skipping
2025/06/22 02:21:02 DEBUG : three.txt: Sizes differ (src 6 vs dst 5)
2025/06/22 02:21:17 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/22 02:21:23 INFO  : three.txt: Deleted
2025/06/22 02:21:28 DEBUG : three.txt: md5 = 1103cf2e575241baa49ae28ff0bb9d11 OK
2025/06/22 02:21:28 INFO  : three.txt: Copied (new)
2025/06/22 02:21:43 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/22 02:21:49 INFO  : one: Copied (server-side copy) to: one.bak
2025/06/22 02:21:54 INFO  : one: Deleted
2025/06/22 02:21:59 DEBUG : one: md5 = 239095b31c325c1d0765fd7591c72a69 OK
2025/06/22 02:21:59 INFO  : one: Copied (new)
2025/06/22 02:21:59 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:21:59 DEBUG : two: Unchanged skipping
2025/06/22 02:21:59 DEBUG : three.txt: Sizes differ (src 19 vs dst 6)
2025/06/22 02:22:09 INFO  : three.txt: Copied (server-side copy) to: three.txt.bak
2025/06/22 02:22:14 INFO  : three.txt: Deleted
2025/06/22 02:22:20 DEBUG : three.txt: md5 = 92ef2406816bda781bef2e76badf59ce OK
2025/06/22 02:22:20 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffix (161.75s)
=== RUN   TestSyncSuffixKeepExtension
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:22:56 DEBUG : dst/one: md5 = 4280b2a456d152b09c4c605f25ebae2e OK
2025/06/22 02:23:01 DEBUG : dst/two: md5 = 0317bca54c470683acfa538f9d0e0482 OK
2025/06/22 02:23:06 DEBUG : dst/three.txt: md5 = 18fe43ccefec1e27be38c36d116c3de9 OK
2025/06/22 02:23:17 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-danexug2wuvi/dst"
2025/06/22 02:23:17 DEBUG : Config file has changed externally - reloading
2025/06/22 02:23:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst.bin"
2025/06/22 02:23:17 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst.bin: Auto set use_segments_container to true
2025/06/22 02:23:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-danexug2wuvi/dst"
2025/06/22 02:23:23 DEBUG : Swift container crypt path rclone-test-danexug2wuvi/dst: Auto set use_segments_container to true
2025/06/22 02:23:28 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/22 02:23:39 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2025/06/22 02:23:44 INFO  : one: Deleted
2025/06/22 02:23:49 DEBUG : one: md5 = 5513b532c7f7242f0e2569f1ba8969ef OK
2025/06/22 02:23:49 INFO  : one: Copied (new)
2025/06/22 02:23:54 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:23:54 DEBUG : two: Unchanged skipping
2025/06/22 02:23:55 DEBUG : three.txt: Sizes differ (src 6 vs dst 5)
2025/06/22 02:24:05 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2025/06/22 02:24:10 INFO  : three.txt: Deleted
2025/06/22 02:24:15 DEBUG : three.txt: md5 = 18fdb6e28adea715129a7e05ac754c68 OK
2025/06/22 02:24:15 INFO  : three.txt: Copied (new)
2025/06/22 02:24:26 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/22 02:24:31 INFO  : one: Copied (server-side copy) to: one-2019-01-01
2025/06/22 02:24:37 INFO  : one: Deleted
2025/06/22 02:24:42 DEBUG : one: md5 = 9357b5089f024e0a5b6f3011489a125b OK
2025/06/22 02:24:42 INFO  : one: Copied (new)
2025/06/22 02:24:42 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:24:42 DEBUG : two: Unchanged skipping
2025/06/22 02:24:42 DEBUG : three.txt: Sizes differ (src 19 vs dst 6)
2025/06/22 02:24:47 INFO  : three.txt: Copied (server-side copy) to: three-2019-01-01.txt
2025/06/22 02:24:52 INFO  : three.txt: Deleted
2025/06/22 02:24:58 DEBUG : three.txt: md5 = 22c3272f9161aa22ec0e6ca7d0be5a49 OK
2025/06/22 02:24:58 INFO  : three.txt: Copied (new)
--- PASS: TestSyncSuffixKeepExtension (153.57s)
=== RUN   TestSyncUTFNorm
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:25:30 DEBUG : Testêé: md5 = 11cd9bd4ad79beb5fed5ff5542bc1636 OK
2025/06/22 02:25:35 DEBUG : Testêé: Sizes differ (src 14 vs dst 18)
2025/06/22 02:25:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 02:25:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 02:25:40 DEBUG : Testêé: md5 = 8d0a136997a21dd9d689a5721ac3040e OK
2025/06/22 02:25:40 INFO  : Testêé: Copied (replaced existing) to: Testêé
2025/06/22 02:25:40 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncUTFNorm (26.10s)
=== RUN   TestSyncImmutable
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:25:51 DEBUG : existing: Need to transfer - File not found at Destination
2025/06/22 02:25:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 02:25:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 02:25:56 DEBUG : existing: md5 = 0fe890f4ad2df9820986139e184c83a5 OK
2025/06/22 02:25:56 INFO  : existing: Copied (new)
2025/06/22 02:25:56 DEBUG : Waiting for deletions to finish
2025/06/22 02:26:01 DEBUG : existing: Sizes differ (src 8 vs dst 6)
2025/06/22 02:26:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 02:26:01 ERROR : existing: Source and destination exist but do not match: immutable file modified
2025/06/22 02:26:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 02:26:01 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': not deleting files as there were IO errors
2025/06/22 02:26:01 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': not deleting directories as there were IO errors
--- PASS: TestSyncImmutable (21.41s)
=== RUN   TestSyncIgnoreCase
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:26:13 DEBUG : EXISTING: md5 = e8914c3bc444eb912ca76c2b16062dc3 OK
2025/06/22 02:26:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 02:26:13 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:26:13 DEBUG : existing: Unchanged skipping
2025/06/22 02:26:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 02:26:13 DEBUG : Waiting for deletions to finish
2025/06/22 02:26:13 INFO  : There was nothing to transfer
--- PASS: TestSyncIgnoreCase (1.73s)
=== RUN   TestFixCase
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:2636: Skipping test as local or remote are case-sensitive
--- SKIP: TestFixCase (0.19s)
=== RUN   TestMaxTransfer
=== RUN   TestMaxTransfer/Hard
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", 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-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", 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-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
    sync_test.go:2675: This test only runs on local
--- PASS: TestMaxTransfer (0.40s)
    --- SKIP: TestMaxTransfer/Hard (0.21s)
    --- SKIP: TestMaxTransfer/Soft (0.10s)
    --- SKIP: TestMaxTransfer/Cautious (0.10s)
=== RUN   TestSyncConcurrentDelete
    run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi'", Local "Local file system at /tmp/rclone3055348682", Modify Window "1ns"
2025/06/22 02:26:20 DEBUG : both0: md5 = 35fd69420c4b043ac56dafd4469cf32e OK
2025/06/22 02:26:25 DEBUG : only0: md5 = 4e76482434b882891d7fb724d86ebf92 OK
2025/06/22 02:26:30 DEBUG : both1: md5 = cd3bed4520459538ed8e79e0f15c00ce OK
2025/06/22 02:26:31 DEBUG : only1: md5 = 298d7c4b27969a44288499e0fc9e65ec OK
2025/06/22 02:26:37 DEBUG : both2: md5 = c2ab303a9e1a354c80694fcb3a4b0d32 OK
2025/06/22 02:26:42 DEBUG : only2: md5 = 885c6d575ebcacaaf01f793587579f66 OK
2025/06/22 02:26:43 DEBUG : both3: md5 = 75e7bca6a7c1cece77c244aebcfe348f OK
2025/06/22 02:26:43 DEBUG : only3: md5 = 953835b9d8d118d7b5dc1dd62dc2a0d7 OK
2025/06/22 02:26:43 DEBUG : both4: md5 = 927da35df960885c3f0d7cfc3b2c6091 OK
2025/06/22 02:26:49 DEBUG : only4: md5 = 5e43436c5703e65df7715d094a0440b1 OK
2025/06/22 02:26:49 DEBUG : both5: md5 = 2339686bdc711317342233d9de1c2013 OK
2025/06/22 02:26:55 DEBUG : only5: md5 = 8174cc9da7a1627e2e78d4a6bc69b340 OK
2025/06/22 02:26:55 DEBUG : both6: md5 = ec9969a80a98f5e8db995f31e5e183b4 OK
2025/06/22 02:27:00 DEBUG : only6: md5 = b4c05b07a0ec5e11ffbd4fb54f32384c OK
2025/06/22 02:27:01 DEBUG : both7: md5 = 84729f3cb3ab41249358ce774960d76c OK
2025/06/22 02:27:01 DEBUG : only7: md5 = 8ce305d930c3ffb60d1ebdda5351f7fe OK
2025/06/22 02:27:02 DEBUG : both8: md5 = 0a15900c769478f9f307270421be476c OK
2025/06/22 02:27:02 DEBUG : only8: md5 = e55a34477b19b6ca17f991a27f7f2212 OK
2025/06/22 02:27:02 DEBUG : both9: md5 = 494fe021910d59ac6e98e194de174c0e OK
2025/06/22 02:27:03 DEBUG : only9: md5 = 88e6a8b1ca691d11e8526494dcbb7a86 OK
2025/06/22 02:27:08 DEBUG : both10: md5 = 29e6f6f20639865296701f8a4fb51043 OK
2025/06/22 02:27:08 DEBUG : only10: md5 = 4a70943b9f2e94732d6b0559df1e0911 OK
2025/06/22 02:27:14 DEBUG : both11: md5 = ca56c4cf538d4db151a6e2178149f6de OK
2025/06/22 02:27:14 DEBUG : only11: md5 = 6a5faaf440206d28dc9f892ecd413199 OK
2025/06/22 02:27:19 DEBUG : both12: md5 = 875529e93b0f08077c0d6984ec9d9006 OK
2025/06/22 02:27:25 DEBUG : only12: md5 = 8b1ec5993a22a835323c88e6a2a479ec OK
2025/06/22 02:27:25 DEBUG : both13: md5 = 697f5af4563c253328d4114a46cc22c7 OK
2025/06/22 02:27:31 DEBUG : only13: md5 = cee4f89118c972dace752ff7eaab387d OK
2025/06/22 02:27:31 DEBUG : both14: md5 = 24a6b2fd9d55cd07ca40ca9afd3ed357 OK
2025/06/22 02:27:37 DEBUG : only14: md5 = 2e70d40b3ee13090781b4589ac604e3b OK
2025/06/22 02:27:37 DEBUG : both15: md5 = 4acdcc70f6d2b36bc910ad29214ebfa3 OK
2025/06/22 02:27:42 DEBUG : only15: md5 = 818d9c77ef18e6863dac31f4c3b8a98a OK
2025/06/22 02:27:48 DEBUG : both16: md5 = d1d8526980d19df9de2ce06a085c0426 OK
2025/06/22 02:27:54 DEBUG : only16: md5 = 8757cdd15cde09890d56a41e2bffec70 OK
2025/06/22 02:27:59 DEBUG : both17: md5 = e5fdda3c825dafcd7be3ca4116f5675a OK
2025/06/22 02:28:04 DEBUG : only17: md5 = 48d23390598cda0f0331a5f068ae69e4 OK
2025/06/22 02:28:05 DEBUG : both18: md5 = 9cf137ab7f5bf02d6c170fab86419ac0 OK
2025/06/22 02:28:10 DEBUG : only18: md5 = 509dbc60ef24ecd258ed57009d11c42f OK
2025/06/22 02:28:15 DEBUG : both19: md5 = b2dfda6eb6ab03c22d9a4c1bad241ae3 OK
2025/06/22 02:28:39 DEBUG : only19: md5 = 47dce9ef36ac48d65f8e9ec669a857ac OK
2025/06/22 02:30:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for checks to finish
2025/06/22 02:30:46 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both0: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both11: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both12: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both13: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both14: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both15: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both18: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both17: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both1: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both19: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both2: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both3: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both4: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both5: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both6: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both7: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both8: Unchanged skipping
2025/06/22 02:30:46 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:30:46 DEBUG : both9: Unchanged skipping
2025/06/22 02:31:09 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:31:09 DEBUG : both10: Unchanged skipping
2025/06/22 02:31:09 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/22 02:31:09 DEBUG : both16: Unchanged skipping
2025/06/22 02:31:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-danexug2wuvi': Waiting for transfers to finish
2025/06/22 02:31:09 DEBUG : Waiting for deletions to finish
2025/06/22 02:31:14 INFO  : only17: Deleted
2025/06/22 02:31:14 INFO  : only12: Deleted
2025/06/22 02:31:14 INFO  : only14: Deleted
2025/06/22 02:31:14 INFO  : only10: Deleted
2025/06/22 02:31:14 INFO  : only15: Deleted
2025/06/22 02:31:14 INFO  : only11: Deleted
2025/06/22 02:31:15 INFO  : only8: Deleted
panic: test timed out after 1h0m0s
	running tests:
		TestSyncConcurrentDelete (5m2s)

goroutine 11975 [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, 5 minutes]:
testing.(*T).Run(0xc0018cb880, {0x26b896c?, 0xc000669ad8?}, 0x27c1940)
	/usr/local/go/src/testing/testing.go:1859 +0x431
testing.runTests.func1(0xc0018cb880)
	/usr/local/go/src/testing/testing.go:2279 +0x37
testing.tRunner(0xc0018cb880, 0xc000669c18)
	/usr/local/go/src/testing/testing.go:1792 +0xf4
testing.runTests(0xc0019f30c8, {0x3e7e5e0, 0x6b, 0x6b}, {0xedfe953e4?, 0x3e945a0?, 0x3e945a0?})
	/usr/local/go/src/testing/testing.go:2277 +0x4b4
testing.(*M).Run(0xc000526820)
	/usr/local/go/src/testing/testing.go:2142 +0x64a
github.com/rclone/rclone/fstest.TestMain(0xc000526820)
	/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 11960 [select]:
github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc000364f00, 0xc000456540, 0xc000b38000)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115
github.com/ncw/swift/v2.(*Connection).Call(0xc000364f00, {0x2af4be8, 0xc0004ff540}, {0xc00021efa0, 0x4f}, {{0xc00056ab70, 0x5}, {0xc00056ab76, 0x23}, {0x2681b0a, ...}, ...})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6
github.com/ncw/swift/v2.(*Connection).storage(0xc000364f00, {0x2af4be8, 0xc0004ff540}, {{0xc00056ab70, 0x5}, {0xc00056ab76, 0x23}, {0x2681b0a, 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, 0xc000100008?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc001b48900, 0xc0007ca000, 0xa)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:197 +0x7c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc001b48900, 0xc0007ca000)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/swift.(*Object).Remove(0xc002239440, {0x2af4be8, 0xc0004ff540})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1619 +0x29b
github.com/rclone/rclone/fs/operations.DeleteFileWithBackupDir({0x2af4be8, 0xc0004ff540}, {0x2b092f0, 0xc00176d6f8}, {0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:556 +0x268
github.com/rclone/rclone/fs/operations.DeleteFilesWithBackupDir.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:591 +0x112
created by github.com/rclone/rclone/fs/operations.DeleteFilesWithBackupDir in goroutine 11675
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:588 +0xe5

goroutine 6 [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 7 [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 11675 [sync.WaitGroup.Wait]:
sync.runtime_SemacquireWaitGroup(0x0?)
	/usr/local/go/src/runtime/sema.go:110 +0x25
sync.(*WaitGroup).Wait(0x2af4b07?)
	/usr/local/go/src/sync/waitgroup.go:118 +0x48
github.com/rclone/rclone/fs/operations.DeleteFilesWithBackupDir({0x2af4be8, 0xc0004ff540}, 0xc0004440e0, {0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:606 +0x1cf
github.com/rclone/rclone/fs/sync.(*syncCopyMove).deleteFiles(0xc0000dc508, 0x0)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:656 +0x1bb
github.com/rclone/rclone/fs/sync.(*syncCopyMove).run(0xc0000dc508)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:986 +0x3f6
github.com/rclone/rclone/fs/sync.runSyncCopyMove({0x2af4bb0, 0xc000000b70}, {0x2b09280, 0xc001a30410}, {0x2b0af60, 0xc0019eab40}, 0x3, 0x0, 0x0, 0x0, ...)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1366 +0x225
github.com/rclone/rclone/fs/sync.Sync({0x2af4bb0, 0xc000000b70}, {0x2b09280, 0xc001a30410}, {0x2b0af60, 0xc0019eab40}, 0x0)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1372 +0x77
github.com/rclone/rclone/fs/sync.testSyncConcurrent(0xc001a85dc0, {0x26815d0, 0x6})
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2748 +0xd05
github.com/rclone/rclone/fs/sync.TestSyncConcurrentDelete(0xc001a85dc0?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2759 +0x1f
testing.tRunner(0xc001a85dc0, 0x27c1940)
	/usr/local/go/src/testing/testing.go:1792 +0xf4
created by testing.(*T).Run in goroutine 1
	/usr/local/go/src/testing/testing.go:1851 +0x413

goroutine 11957 [select]:
github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc000364f00, 0xc0000fd960, 0xc0000d3e00)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115
github.com/ncw/swift/v2.(*Connection).Call(0xc000364f00, {0x2af4be8, 0xc0004ff540}, {0xc00021efa0, 0x4f}, {{0xc001b70300, 0x5}, {0xc001b70306, 0x23}, {0x2681b0a, ...}, ...})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6
github.com/ncw/swift/v2.(*Connection).storage(0xc000364f00, {0x2af4be8, 0xc0004ff540}, {{0xc001b70300, 0x5}, {0xc001b70306, 0x23}, {0x2681b0a, 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, 0xc000500008?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc001b48900, 0xc0019da780, 0xa)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:197 +0x7c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc001b48900, 0xc0019da780)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/swift.(*Object).Remove(0xc002239380, {0x2af4be8, 0xc0004ff540})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1619 +0x29b
github.com/rclone/rclone/fs/operations.DeleteFileWithBackupDir({0x2af4be8, 0xc0004ff540}, {0x2b092f0, 0xc00176d6c8}, {0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:556 +0x268
github.com/rclone/rclone/fs/operations.DeleteFilesWithBackupDir.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:591 +0x112
created by github.com/rclone/rclone/fs/operations.DeleteFilesWithBackupDir in goroutine 11675
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:588 +0xe5

goroutine 11899 [IO wait]:
internal/poll.runtime_pollWait(0x7d6f247276f0, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc001a76300?, 0xc000c47980?, 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(0xc001a76300, {0xc000c47980, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc001a76300, {0xc000c47980?, 0xc00055e8d0?, 0x42b5fc?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc00012a348, {0xc000c47980?, 0x422eb6?, 0x3eba3e0?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0019f2828, {0xc000c47980?, 0x7d6f24521128?, 0x7d6f6cbc05c0?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc001f64000, {0xc000c47980?, 0x3eba3e0?, 0xc00055e9c8?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0001490b8, {0x2acf520, 0xc001f64000})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000148e08, {0x7d6f24640068, 0xc0019f2828}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000148e08, 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(0xc000148e08, {0xc0005f0000, 0x1000, 0xc00060a030?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000c36120, {0xc0005f0000?, 0x7f4ea5?, 0x2acc440?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc001ff7d40)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc001ff7d40, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000c36120)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 11885
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

goroutine 11568 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc000638d20, {0x2af4be8, 0xc000419a90})
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 11555
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x117

goroutine 12015 [select]:
net/http.(*persistConn).roundTrip(0xc000034d80, 0xc0019da960)
	/usr/local/go/src/net/http/transport.go:2826 +0x785
net/http.(*Transport).roundTrip(0xc000038340, 0xc0019b2140)
	/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(0xc0000e0070, 0xc0019b2140)
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345
net/http.send(0xc0019b2140, {0x2acdfc0, 0xc0000e0070}, {0x3e9f801?, 0xc000557da0?, 0x0?})
	/usr/local/go/src/net/http/client.go:259 +0x5e2
net/http.(*Client).send(0xc0019fb5c0, 0xc0019b2140, {0x0?, 0x0?, 0x0?})
	/usr/local/go/src/net/http/client.go:180 +0x91
net/http.(*Client).do(0xc0019fb5c0, 0xc0019b2140)
	/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 11958
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8

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

goroutine 11956 [select]:
github.com/rclone/rclone/fs/sync.(*syncCopyMove).deleteFiles.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:648 +0x186
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).deleteFiles in goroutine 11675
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:636 +0x193

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

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

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

goroutine 11907 [IO wait]:
internal/poll.runtime_pollWait(0x7d6f24727060, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000450080?, 0xc000c46000?, 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(0xc000450080, {0xc000c46000, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000450080, {0xc000c46000?, 0x1973?, 0xc001d7c6e0?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc001d983a8, {0xc000c46000?, 0xc0003f0550?, 0xd?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc001ebb098, {0xc000c46000?, 0x7d6f248c0c08?, 0x7d6f6cbc0108?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc0001d74a0, {0xc000c46000?, 0x1973?, 0xc0000959d0?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0003f0638, {0x2acf520, 0xc0001d74a0})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc0003f0388, {0x7d6f24640068, 0xc001ebb098}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc0003f0388, 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(0xc0003f0388, {0xc000764000, 0x1000, 0xc00060a030?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000034d80, {0xc000764000?, 0x7f4ea5?, 0x2acc440?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc001cd1920)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc001cd1920, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000034d80)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 11870
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

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

goroutine 11972 [select]:
net/http.(*persistConn).roundTrip(0xc000c36120, 0xc0007ca0a0)
	/usr/local/go/src/net/http/transport.go:2826 +0x785
net/http.(*Transport).roundTrip(0xc000038340, 0xc000b38000)
	/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(0xc0000e0070, 0xc000b38000)
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345
net/http.send(0xc000b38000, {0x2acdfc0, 0xc0000e0070}, {0xc000074201?, 0xc00055fda0?, 0x0?})
	/usr/local/go/src/net/http/client.go:259 +0x5e2
net/http.(*Client).send(0xc0019fb5c0, 0xc000b38000, {0x0?, 0x0?, 0x0?})
	/usr/local/go/src/net/http/client.go:180 +0x91
net/http.(*Client).do(0xc0019fb5c0, 0xc000b38000)
	/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 11960
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8

goroutine 11863 [chan receive, 2 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 11675
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378

goroutine 11909 [IO wait, 2 minutes]:
internal/poll.runtime_pollWait(0x7d6f24727290, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc001a76380?, 0xc000c49300?, 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(0xc001a76380, {0xc000c49300, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc001a76380, {0xc000c49300?, 0xc000c36000?, 0x41d4ae?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc00012a358, {0xc000c49300?, 0xc0008c87e0?, 0x5?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0019f2870, {0xc000c49300?, 0x7d6f244e1bb8?, 0x7d6f6cbc05c0?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc0019f2d50, {0xc000c49300?, 0xc000038340?, 0x8159bc?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000149438, {0x2acf520, 0xc0019f2d50})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000149188, {0x7d6f24640068, 0xc0019f2870}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000149188, 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(0xc000149188, {0xc000766000, 0x1000, 0x7d6f6cbc05c0?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc0000350e0, {0xc000766000?, 0x412565?, 0x68?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc001cd1b00)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc001cd1b00, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc0000350e0)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 11895
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

goroutine 2056 [chan receive, 51 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 2068
	/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68

goroutine 11856 [IO wait]:
internal/poll.runtime_pollWait(0x7d6f24727178, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000450000?, 0xc00024cc80?, 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(0xc000450000, {0xc00024cc80, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000450000, {0xc00024cc80?, 0x1973?, 0xc001cceec0?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc00012a340, {0xc00024cc80?, 0xc0001481d0?, 0xd?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0019f27e0, {0xc00024cc80?, 0x7d6f248c0c08?, 0x7d6f6cbc0108?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc0001d6ba0, {0xc00024cc80?, 0x1973?, 0xc0005509d0?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0001482b8, {0x2acf520, 0xc0001d6ba0})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000148008, {0x7d6f24640068, 0xc0019f27e0}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000148008, 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(0xc000148008, {0xc0007ed000, 0x1000, 0xc00060a030?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000c36000, {0xc0007ed000?, 0x7f4ea5?, 0x2acc440?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc001f6ca20)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc001f6ca20, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000c36000)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 11882
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

goroutine 11107 [IO wait]:
internal/poll.runtime_pollWait(0x7d6f247273a8, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000450480?, 0xc0006aa000?, 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(0xc000450480, {0xc0006aa000, 0x3500, 0x3500})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000450480, {0xc0006aa000?, 0x34f3?, 0xc001d7c420?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc001d98048, {0xc0006aa000?, 0xc000148c50?, 0xd?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc002066210, {0xc0006aa000?, 0x7d6f248c0c08?, 0x7d6f6cbc0108?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc0001d7338, {0xc0006aa000?, 0x34f3?, 0xc001d899d0?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc000148d38, {0x2acf520, 0xc0001d7338})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000148a88, {0x7d6f24640068, 0xc002066210}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000148a88, 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(0xc000148a88, {0xc0005e7000, 0x1000, 0xc00060a030?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc00069ec60, {0xc0005e7000?, 0x7f4ea5?, 0x2acc440?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc001a83d40)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc001a83d40, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc00069ec60)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 10941
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

goroutine 12005 [select]:
net/http.(*persistConn).roundTrip(0xc000c36000, 0xc0019da370)
	/usr/local/go/src/net/http/transport.go:2826 +0x785
net/http.(*Transport).roundTrip(0xc000038340, 0xc0000d3540)
	/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(0xc0000e0070, 0xc0000d3540)
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345
net/http.send(0xc0000d3540, {0x2acdfc0, 0xc0000e0070}, {0x1?, 0x2?, 0x0?})
	/usr/local/go/src/net/http/client.go:259 +0x5e2
net/http.(*Client).send(0xc0019fb5c0, 0xc0000d3540, {0x412c3e?, 0x482592?, 0x0?})
	/usr/local/go/src/net/http/client.go:180 +0x91
net/http.(*Client).do(0xc0019fb5c0, 0xc0000d3540)
	/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 11959
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8

goroutine 11959 [select]:
github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc000364f00, 0xc0000fcb60, 0xc0000d3540)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115
github.com/ncw/swift/v2.(*Connection).Call(0xc000364f00, {0x2af4be8, 0xc0004ff540}, {0xc00021efa0, 0x4f}, {{0xc001b701b0, 0x5}, {0xc001b701b6, 0x22}, {0x267ad24, ...}, ...})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6
github.com/ncw/swift/v2.(*Connection).storage(0xc000364f00, {0x2af4be8, 0xc0004ff540}, {{0xc001b701b0, 0x5}, {0xc001b701b6, 0x22}, {0x267ad24, 0x4}, 0x0, ...})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:847 +0x151
github.com/ncw/swift/v2.(*Connection).objectBase(0x0?, {0x2af4be8?, 0xc0004ff540?}, {0xc001b701b0?, 0x0?}, {0xc001b701b6, 0x22})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2143 +0xf8
github.com/rclone/rclone/backend/swift.(*Object).readMetaData.func1.(*Connection).Object.1()
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2132 +0x85
github.com/ncw/swift/v2.withLORetry(0x0, 0xc0007fda88)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/largeobjects.go:303 +0x9f
github.com/ncw/swift/v2.(*Connection).Object(...)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2131
github.com/rclone/rclone/backend/swift.(*Object).readMetaData.func1()
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1334 +0x156
github.com/rclone/rclone/fs.pacerInvoker(0x1, 0xa, 0xc000100008?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc001b48900, 0xc0021da0c0, 0xa)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:197 +0x7c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc001b48900, 0xc0021da0c0)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/swift.(*Object).readMetaData(0xc002239500, {0x2af4be8, 0xc0004ff540})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1333 +0x165
github.com/rclone/rclone/backend/swift.(*Object).hasHeader(0xc002239500, {0x2af4be8?, 0xc0004ff540?}, {0x26af664, 0x15})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1246 +0x30
github.com/rclone/rclone/backend/swift.(*Object).isLargeObject(0xc002239500, {0x2af4be8, 0xc0004ff540})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1277 +0x48
github.com/rclone/rclone/backend/swift.(*Object).Remove(0xc002239500, {0x2af4be8, 0xc0004ff540})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1597 +0x96
github.com/rclone/rclone/fs/operations.DeleteFileWithBackupDir({0x2af4be8, 0xc0004ff540}, {0x2b092f0, 0xc00176d728}, {0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:556 +0x268
github.com/rclone/rclone/fs/operations.DeleteFilesWithBackupDir.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:591 +0x112
created by github.com/rclone/rclone/fs/operations.DeleteFilesWithBackupDir in goroutine 11675
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:588 +0xe5

goroutine 11958 [select]:
github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc000364f00, 0xc0000fdc70, 0xc0019b2140)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115
github.com/ncw/swift/v2.(*Connection).Call(0xc000364f00, {0x2af4be8, 0xc0004ff540}, {0xc00021efa0, 0x4f}, {{0xc0019aa180, 0x5}, {0xc0019aa186, 0x23}, {0x2681b0a, ...}, ...})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6
github.com/ncw/swift/v2.(*Connection).storage(0xc000364f00, {0x2af4be8, 0xc0004ff540}, {{0xc0019aa180, 0x5}, {0xc0019aa186, 0x23}, {0x2681b0a, 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, 0xc000100008?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc001b48900, 0xc0019da8c0, 0xa)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:197 +0x7c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc001b48900, 0xc0019da8c0)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/swift.(*Object).Remove(0xc0022394a0, {0x2af4be8, 0xc0004ff540})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1619 +0x29b
github.com/rclone/rclone/fs/operations.DeleteFileWithBackupDir({0x2af4be8, 0xc0004ff540}, {0x2b092f0, 0xc00176d710}, {0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:556 +0x268
github.com/rclone/rclone/fs/operations.DeleteFilesWithBackupDir.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:591 +0x112
created by github.com/rclone/rclone/fs/operations.DeleteFilesWithBackupDir in goroutine 11675
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:588 +0xe5

goroutine 12013 [select]:
net/http.(*persistConn).roundTrip(0xc00069ec60, 0xc0019da820)
	/usr/local/go/src/net/http/transport.go:2826 +0x785
net/http.(*Transport).roundTrip(0xc000038340, 0xc0000d3e00)
	/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(0xc0000e0070, 0xc0000d3e00)
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345
net/http.send(0xc0000d3e00, {0x2acdfc0, 0xc0000e0070}, {0x1?, 0x2?, 0x0?})
	/usr/local/go/src/net/http/client.go:259 +0x5e2
net/http.(*Client).send(0xc0019fb5c0, 0xc0000d3e00, {0x412c3e?, 0x482592?, 0x0?})
	/usr/local/go/src/net/http/client.go:180 +0x91
net/http.(*Client).do(0xc0019fb5c0, 0xc0000d3e00)
	/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 11957
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8
"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished ERROR in 1h0m11.484721182s (try 1/5): exit status 2: Failed []