"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 4/5) 2025/07/05 07:15:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe" 2025/07/05 07:15:32 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/05 07:15:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe.bin" 2025/07/05 07:15:32 DEBUG : Swift container crypt path rclone-test-tizewol7rohe.bin: Auto set use_segments_container to true 2025/07/05 07:15:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe" 2025/07/05 07:15:38 DEBUG : Swift container crypt path rclone-test-tizewol7rohe: Auto set use_segments_container to true 2025/07/05 07:15:43 DEBUG : Creating backend with remote "/tmp/rclone2770026733" === 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-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:15:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:15:43 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/07/05 07:15:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:15:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish --- PASS: TestCopyWithDryRun (0.40s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:15:44 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/07/05 07:15:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:15:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:15:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:15:49 DEBUG : sub dir/hello world: md5 = 4fc8bf0c0f48305d4bbcb71ae562a5ec OK 2025/07/05 07:15:49 INFO : sub dir/hello world: Copied (new) 2025/07/05 07:15:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (15.99s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:98: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.10s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:98: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.28s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:16:00 DEBUG : Creating backend with remote "/non-existing" 2025/07/05 07:16:00 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/07/05 07:16:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:16:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.22s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:16:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:16:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:16:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:16:16 DEBUG : sub dir/hello world: md5 = 7d10883589d3ce7967f8ada17a3bf7db OK 2025/07/05 07:16:16 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (31.03s) === RUN TestCopyNoTraverseDeadlock run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:222: Only runs on local --- SKIP: TestCopyNoTraverseDeadlock (0.25s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:16:31 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Running all checks before starting transfers 2025/07/05 07:16:31 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:16:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:16:31 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Checks finished, now starting transfers 2025/07/05 07:16:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:16:37 DEBUG : sub dir/hello world: md5 = 637cb27c0f55ff5b54829ace9e7992d3 OK 2025/07/05 07:16:37 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (15.62s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:16:47 ERROR : Ignoring --no-traverse with sync 2025/07/05 07:16:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:16:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:16:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:16:52 DEBUG : sub dir/hello world: md5 = f3d9ede06f0c0eb170bc2af03e65efc7 OK 2025/07/05 07:16:52 INFO : sub dir/hello world: Copied (new) 2025/07/05 07:16:52 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (15.76s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:17:03 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/07/05 07:17:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:17:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:17:03 DEBUG : hello world2: md5 = 605c9b948db76687951367304e0b7783 OK 2025/07/05 07:17:03 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (1.03s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:17:04 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:17:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:17:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:17:09 DEBUG : potato2: md5 = 5e4252e14b00b20f20e96a9503e1fa46 OK 2025/07/05 07:17:09 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (15.89s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:17:25 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:17:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:17:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:17:30 DEBUG : potato2: md5 = 6a20419ce0153902aa630d61dfcd3d34 OK 2025/07/05 07:17:30 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (20.85s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:17:41 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/07/05 07:17:41 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 07:17:41 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/07/05 07:17:41 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/07/05 07:17:41 INFO : sub dir2: Making directory 2025/07/05 07:17:41 INFO : sub dir: Making directory 2025/07/05 07:17:41 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:17:41 INFO : sub dir2/sub sub dir2: Making directory 2025/07/05 07:17:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:17:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:17:46 DEBUG : sub dir/hello world: md5 = e7af34b733c63b4d6b74d33d86d51be4 OK 2025/07/05 07:17:46 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/07/05 07:17:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (20.92s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:18:02 INFO : sub dir2: Making directory 2025/07/05 07:18:02 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/07/05 07:18:02 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 07:18:02 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:18:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:18:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:18:07 DEBUG : sub dir/hello world: md5 = 08ae0c090ee8c35e92999ebc2d1889c8 OK 2025/07/05 07:18:07 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (20.80s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:18:22 DEBUG : sub dir2: Making directory with metadata 2025/07/05 07:18:22 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 07:18:22 INFO : sub dir2: Making directory 2025/07/05 07:18:22 INFO : sub dir: Making directory 2025/07/05 07:18:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:18:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:18:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:18:27 DEBUG : sub dir/hello world: md5 = 930e707706c026bad19e2df79b0b5eed OK 2025/07/05 07:18:27 INFO : sub dir/hello world: Copied (new) 2025/07/05 07:18:27 INFO : sub dir/hello world: Deleted fstest.go:247: Filtering empty directory "sub dir2" 2025/07/05 07:18:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/07/05 07:18:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (16.05s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:438: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.30s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:18:39 INFO : sub dir2: Making directory 2025/07/05 07:18:39 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:18:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:18:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:18:44 DEBUG : sub dir/hello world: md5 = c208357f8f0c657043f8c69cc97e3dfd OK 2025/07/05 07:18:44 INFO : sub dir/hello world: Copied (new) 2025/07/05 07:18:44 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (20.59s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:18:59 DEBUG : sub dir2: Making directory with metadata 2025/07/05 07:18:59 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 07:18:59 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/07/05 07:18:59 INFO : sub dir2: Making directory 2025/07/05 07:18:59 INFO : sub dir: Making directory 2025/07/05 07:18:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:18:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:18:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:19:04 DEBUG : sub dir/hello world: md5 = bfbe82ca6af3ce846f745fc3e44d08f8 OK 2025/07/05 07:19:04 INFO : sub dir/hello world: Copied (new) 2025/07/05 07:19:04 DEBUG : Waiting for deletions to finish fstest.go:247: Filtering empty directory "sub dir2" 2025/07/05 07:19:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (15.74s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:537: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.19s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:19:15 INFO : sub dir2: Making directory 2025/07/05 07:19:15 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:19:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:19:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:19:20 DEBUG : sub dir/hello world: md5 = 41c18f98931ae90b285702534ef00cff OK 2025/07/05 07:19:20 INFO : sub dir/hello world: Copied (new) 2025/07/05 07:19:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (10.81s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:19:31 DEBUG : sub dir/hello world: md5 = 601e820eaeb423e052865f3ee1329dac OK 2025/07/05 07:19:31 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-buyucol6buwe" 2025/07/05 07:19:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-buyucol6buwe.bin" 2025/07/05 07:19:32 DEBUG : Swift container crypt path rclone-test-buyucol6buwe.bin: Auto set use_segments_container to true 2025/07/05 07:19:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-buyucol6buwe" 2025/07/05 07:19:38 DEBUG : Swift container crypt path rclone-test-buyucol6buwe: Auto set use_segments_container to true sync_test.go:620: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe' -> Encrypted drive 'TestCryptSwift:rclone-test-buyucol6buwe' 2025/07/05 07:19:48 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:19:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-buyucol6buwe': Waiting for checks to finish 2025/07/05 07:19:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-buyucol6buwe': Waiting for transfers to finish 2025/07/05 07:19:59 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 07:20:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-buyucol6buwe': Purge remote 2025/07/05 07:20:04 DEBUG : Waiting for deletions to finish 2025/07/05 07:20:14 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (53.53s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:20:25 DEBUG : sub dir/hello world: md5 = 10a39799f9762691f2cf75cd9c70e002 OK 2025/07/05 07:20:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:20:30 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/05 07:20:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:20:40 DEBUG : sub dir/hello world: md5 = 0bbbdb04185755887bba4bb46d1df2b0 OK 2025/07/05 07:20:40 INFO : sub dir/hello world: Copied (replaced existing) --- PASS: TestCopyOverSelf (31.48s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:20:56 DEBUG : sub dir/hello world: md5 = da2c0dbdd532b4edb9d248d5d3b8b4eb OK 2025/07/05 07:21:01 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-daperam0kupe" 2025/07/05 07:21:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-daperam0kupe.bin" 2025/07/05 07:21:02 DEBUG : Swift container crypt path rclone-test-daperam0kupe.bin: Auto set use_segments_container to true 2025/07/05 07:21:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-daperam0kupe" 2025/07/05 07:21:07 DEBUG : Swift container crypt path rclone-test-daperam0kupe: Auto set use_segments_container to true sync_test.go:656: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe' -> Encrypted drive 'TestCryptSwift:rclone-test-daperam0kupe' 2025/07/05 07:21:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:21:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-daperam0kupe': Waiting for checks to finish 2025/07/05 07:21:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-daperam0kupe': Waiting for transfers to finish 2025/07/05 07:21:23 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 07:21:29 DEBUG : sub dir/hello world: md5 = 6c78508eca931ea09518fef0d37754be OK 2025/07/05 07:21:29 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/05 07:21:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-daperam0kupe': Waiting for checks to finish 2025/07/05 07:21:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-daperam0kupe': Waiting for transfers to finish 2025/07/05 07:21:44 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 07:21:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-daperam0kupe': Purge remote 2025/07/05 07:21:45 DEBUG : Waiting for deletions to finish 2025/07/05 07:21:50 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (69.07s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:22:05 DEBUG : sub dir/hello world: md5 = 99d3dbd866758451052f24cff743efb7 OK 2025/07/05 07:22:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:22:05 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/05 07:22:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:22:11 DEBUG : sub dir/hello world: md5 = 84c49cc1259b60bf6d581b04264f8990 OK 2025/07/05 07:22:11 INFO : sub dir/hello world: Copied (replaced existing) 2025/07/05 07:22:11 INFO : sub dir/hello world: Deleted --- PASS: TestMoveOverSelf (21.08s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:22:26 DEBUG : sub dir/hello world: md5 = bee708b780f1f9eb8ad85d49cc40ead6 OK 2025/07/05 07:22:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bafafap8neqa" 2025/07/05 07:22:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bafafap8neqa.bin" 2025/07/05 07:22:27 DEBUG : Swift container crypt path rclone-test-bafafap8neqa.bin: Auto set use_segments_container to true 2025/07/05 07:22:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bafafap8neqa" 2025/07/05 07:22:33 DEBUG : Swift container crypt path rclone-test-bafafap8neqa: Auto set use_segments_container to true sync_test.go:701: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe' -> Encrypted drive 'TestCryptSwift:rclone-test-bafafap8neqa' 2025/07/05 07:22:38 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:22:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bafafap8neqa': Waiting for checks to finish 2025/07/05 07:22:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bafafap8neqa': Waiting for transfers to finish 2025/07/05 07:22:49 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 07:22:54 DEBUG : sub dir/hello world: md5 = 2667ac9fa63935967f336bbe5025ffa9 OK 2025/07/05 07:22:59 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/05 07:22:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bafafap8neqa': Waiting for checks to finish 2025/07/05 07:23:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bafafap8neqa': Waiting for transfers to finish 2025/07/05 07:23:15 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 07:23:20 INFO : sub dir/hello world: Deleted 2025/07/05 07:23:25 DEBUG : sub dir/hello world: md5 = f348bf8f316f6b104dc5a73641a3a9ef OK 2025/07/05 07:23:25 DEBUG : testing file moves 2025/07/05 07:23:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bafafap8neqa': Waiting for checks to finish 2025/07/05 07:23:26 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/07/05 07:23:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bafafap8neqa': Waiting for transfers to finish 2025/07/05 07:23:41 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 07:23:46 INFO : sub dir/hello world: Deleted 2025/07/05 07:23:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bafafap8neqa': Purge remote 2025/07/05 07:23:46 DEBUG : Waiting for deletions to finish 2025/07/05 07:23:52 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (90.73s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:23:57 DEBUG : sub dir/hello world: md5 = 84dee2c4a395430ba3add294157f908e OK 2025/07/05 07:23:57 ERROR : error listing: directory not found 2025/07/05 07:23:57 INFO : Local file system at /tmp/rclone2770026733: Making directory 2025/07/05 07:24:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:24:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish --- PASS: TestCopyAfterDelete (16.00s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:24:13 DEBUG : sub dir/hello world: md5 = 7874d616c3d2bd3c683223ff03192da5 OK 2025/07/05 07:24:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:24:13 DEBUG : Local file system at /tmp/rclone2770026733: Waiting for checks to finish 2025/07/05 07:24:13 DEBUG : Local file system at /tmp/rclone2770026733: Waiting for transfers to finish 2025/07/05 07:24:14 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/07/05 07:24:14 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (16.06s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:24:24 DEBUG : check sum: Need to transfer - File not found at Destination 2025/07/05 07:24:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:24:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:24:30 DEBUG : check sum: md5 = 572637f3fdc7810ebf08a3bc7ceacf49 OK 2025/07/05 07:24:30 INFO : check sum: Copied (new) 2025/07/05 07:24:30 DEBUG : Waiting for deletions to finish 2025/07/05 07:24:30 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/07/05 07:24:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:24:30 DEBUG : check sum: Size of src and dst objects identical 2025/07/05 07:24:30 DEBUG : check sum: Unchanged skipping 2025/07/05 07:24:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:24:30 DEBUG : Waiting for deletions to finish 2025/07/05 07:24:30 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (11.67s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:24:36 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/07/05 07:24:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:24:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:24:36 DEBUG : sizeonly: md5 = e717040011f7e3d78611554e403a7046 OK 2025/07/05 07:24:36 INFO : sizeonly: Copied (new) 2025/07/05 07:24:36 DEBUG : Waiting for deletions to finish 2025/07/05 07:24:37 DEBUG : sizeonly: Sizes identical 2025/07/05 07:24:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:24:37 DEBUG : sizeonly: Unchanged skipping 2025/07/05 07:24:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:24:37 DEBUG : Waiting for deletions to finish 2025/07/05 07:24:37 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (1.78s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:24:38 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/07/05 07:24:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:24:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:24:43 DEBUG : ignore-size: md5 = 7af4ef8d835399474415380f2bd36756 OK 2025/07/05 07:24:43 INFO : ignore-size: Copied (new) 2025/07/05 07:24:43 DEBUG : Waiting for deletions to finish 2025/07/05 07:24:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:24:48 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:24:48 DEBUG : ignore-size: Unchanged skipping 2025/07/05 07:24:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:24:48 DEBUG : Waiting for deletions to finish 2025/07/05 07:24:48 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (21.33s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:25:04 DEBUG : existing: md5 = ada02f74d493efc59c48ddc330f39dde OK 2025/07/05 07:25:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:25:15 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:25:15 DEBUG : existing: Unchanged skipping 2025/07/05 07:25:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:25:15 DEBUG : Waiting for deletions to finish 2025/07/05 07:25:15 INFO : There was nothing to transfer 2025/07/05 07:25:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:25:15 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/07/05 07:25:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:25:25 DEBUG : existing: md5 = ab6ab81ae12080a9be2082c4b77451ce OK 2025/07/05 07:25:25 INFO : existing: Copied (replaced existing) 2025/07/05 07:25:25 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (31.77s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:25:31 DEBUG : existing: Need to transfer - File not found at Destination 2025/07/05 07:25:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:25:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:25:36 DEBUG : existing: md5 = 90535200863f588d0b7d3496fe0aef4f OK 2025/07/05 07:25:36 INFO : existing: Copied (new) 2025/07/05 07:25:36 DEBUG : Waiting for deletions to finish 2025/07/05 07:25:41 DEBUG : existing: Destination exists, skipping 2025/07/05 07:25:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:25:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:25:41 DEBUG : Waiting for deletions to finish 2025/07/05 07:25:41 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (21.13s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:25:52 DEBUG : b/potato: md5 = 62991211735c307f5b3dbe6ac398d17d OK 2025/07/05 07:25:57 DEBUG : c/non empty space: md5 = 2c3a16e4ebce9e3374aa891fabbe8382 OK 2025/07/05 07:25:57 INFO : d: Making directory fstest.go:247: Filtering empty directory "d" 2025/07/05 07:25:58 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/07/05 07:25:58 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:25:58 DEBUG : c/non empty space: Unchanged skipping 2025/07/05 07:25:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:25:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:25:58 DEBUG : a/potato2: md5 = c7b72342ac72e357db3331fd8342b95d OK 2025/07/05 07:25:58 INFO : a/potato2: Copied (new) 2025/07/05 07:25:58 DEBUG : Waiting for deletions to finish 2025/07/05 07:25:58 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (17.21s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:26:14 DEBUG : empty space: md5 = 295b88e3a4dc16fd47a430f9bbe27d0f OK 2025/07/05 07:26:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:26:19 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/07/05 07:26:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:26:19 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/07/05 07:26:19 DEBUG : Waiting for deletions to finish 2025/07/05 07:26:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:26:25 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/07/05 07:26:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:26:30 DEBUG : empty space: md5 = 31d0389c5284f31247bca8f7d8d34882 OK 2025/07/05 07:26:30 INFO : empty space: Copied (replaced existing) 2025/07/05 07:26:30 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingModtimeOnly (26.69s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:1046: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.19s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:26:36 DEBUG : foo: md5 = fb4cfa8fbb3854e43f3a66e526ebb029 OK 2025/07/05 07:26:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:26:37 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/07/05 07:26:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:26:37 DEBUG : foo: md5 = 8066098192020db4bb079740cd0963d6 OK 2025/07/05 07:26:37 INFO : foo: Copied (replaced existing) 2025/07/05 07:26:37 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (2.09s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:26:43 DEBUG : empty space: md5 = ee7802491e70e813578a1de774b3e5f0 OK 2025/07/05 07:26:43 DEBUG : potato: Need to transfer - File not found at Destination 2025/07/05 07:26:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:26:43 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:26:43 DEBUG : empty space: Unchanged skipping 2025/07/05 07:26:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:26:44 DEBUG : potato: md5 = 7d83606aa119a8a7e1b17e31e41c7f55 OK 2025/07/05 07:26:44 INFO : potato: Copied (new) 2025/07/05 07:26:44 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (16.74s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:26:55 DEBUG : potato: md5 = 094635c8610630243479e1882bb57b64 OK 2025/07/05 07:26:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:26:55 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/07/05 07:26:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:26:56 DEBUG : potato: md5 = df25ad222b46a4d0d91e74a6acca6c5c OK 2025/07/05 07:26:56 INFO : potato: Copied (replaced existing) 2025/07/05 07:26:56 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (1.75s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:26:57 DEBUG : potato: md5 = eeee3bf2e937280e5692fd4181644082 OK 2025/07/05 07:26:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:26:57 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/07/05 07:26:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:26:57 DEBUG : potato: md5 = 3c52a59d2b2a43553bdc9a2fe9075880 OK 2025/07/05 07:26:57 INFO : potato: Copied (replaced existing) 2025/07/05 07:26:57 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (1.56s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:26:58 DEBUG : potato: md5 = 04a3863990cce55c9af888a58e77d7e3 OK 2025/07/05 07:27:03 DEBUG : empty space: md5 = 803cf3d059912d0aac4e7297378bf6f1 OK 2025/07/05 07:27:03 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:27:03 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/07/05 07:27:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:27:08 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:27:08 DEBUG : empty space: Unchanged skipping 2025/07/05 07:27:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:27:08 DEBUG : Waiting for deletions to finish 2025/07/05 07:27:08 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (21.62s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:27:20 DEBUG : potato: md5 = f29ff18a9ed071997ed48e04cbf9c36f OK 2025/07/05 07:27:25 DEBUG : empty space: md5 = 6dc5ab55fc65e5b7100b8c1e321e26fd OK 2025/07/05 07:27:30 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:27:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:27:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:27:35 DEBUG : empty space: Unchanged skipping 2025/07/05 07:27:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:27:35 DEBUG : potato2: md5 = c00bd3cdca2542c755f7429cba3dcaad OK 2025/07/05 07:27:35 INFO : potato2: Copied (new) 2025/07/05 07:27:35 DEBUG : Waiting for deletions to finish 2025/07/05 07:27:36 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (32.11s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:27:52 DEBUG : b/potato: md5 = 9ee4a8121759d7a9244e88baefc88291 OK 2025/07/05 07:27:57 DEBUG : c/non empty space: md5 = 60c9736a1405228b9ae8d2894214f9c3 OK 2025/07/05 07:27:57 INFO : d: Making directory 2025/07/05 07:27:57 INFO : d/e: Making directory fstest.go:247: Filtering empty directory "d" fstest.go:247: Filtering empty directory "d/e" 2025/07/05 07:28:02 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/07/05 07:28:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:28:03 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:28:03 DEBUG : c/non empty space: Unchanged skipping 2025/07/05 07:28:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:28:03 DEBUG : a/potato2: md5 = f21b3165d0778732428644dfc8d55054 OK 2025/07/05 07:28:03 INFO : a/potato2: Copied (new) 2025/07/05 07:28:03 DEBUG : Waiting for deletions to finish 2025/07/05 07:28:03 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (22.01s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:28:14 DEBUG : b/potato: md5 = 896f5eaca5da4c34a896345236638674 OK 2025/07/05 07:28:19 DEBUG : c/non empty space: md5 = d5b56e241750eada61c3f5d1e7151b7b OK 2025/07/05 07:28:19 INFO : d: Making directory fstest.go:247: Filtering empty directory "d" 2025/07/05 07:28:24 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/07/05 07:28:24 DEBUG : a/potato2: md5 = 48a1b1451c3bcfb762c2ed80871228ce OK 2025/07/05 07:28:24 INFO : a/potato2: Copied (new) 2025/07/05 07:28:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:28:29 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:28:29 DEBUG : c/non empty space: Unchanged skipping 2025/07/05 07:28:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:28:29 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': not deleting files as there were IO errors 2025/07/05 07:28:29 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': not deleting directories as there were IO errors fstest.go:247: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (26.95s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:28:41 DEBUG : potato: md5 = 569431830420a8b2a397b7edbf253bf0 OK 2025/07/05 07:28:46 DEBUG : empty space: md5 = 19831ec68c8a49d82ff0bc4d00073fd4 OK 2025/07/05 07:28:51 DEBUG : Waiting for deletions to finish 2025/07/05 07:28:51 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:28:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:28:51 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:28:51 DEBUG : empty space: Unchanged skipping 2025/07/05 07:28:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:28:51 INFO : potato: Deleted 2025/07/05 07:28:56 DEBUG : potato2: md5 = a9dda33f90fb5aa984ae3ba926070ff6 OK 2025/07/05 07:28:56 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteDuring (37.58s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:29:18 DEBUG : potato: md5 = 230dccae53c6297c46ec9dca9a45913c OK 2025/07/05 07:29:23 DEBUG : empty space: md5 = 193915b2be6a9692cceb32195f1944d5 OK 2025/07/05 07:29:29 DEBUG : Waiting for deletions to finish 2025/07/05 07:29:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:29:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:29:29 INFO : potato: Deleted 2025/07/05 07:29:29 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:29:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:29:34 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:29:34 DEBUG : empty space: Unchanged skipping 2025/07/05 07:29:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:29:34 DEBUG : potato2: md5 = 7bc6b4878e2c7a1fe6ee0066a6d622bb OK 2025/07/05 07:29:34 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (42.60s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:30:01 DEBUG : potato: md5 = dd7c4e031c0aad859047308d7d35b6f3 OK 2025/07/05 07:30:03 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:30:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:30:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:30:08 DEBUG : potato2: md5 = 84138c50a163e03a96e0689cd78260bb OK 2025/07/05 07:30:08 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (18.02s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:30:24 DEBUG : potato2: md5 = 3d8739a0b75779434bf360d9ee519dab OK 2025/07/05 07:30:29 DEBUG : empty space: md5 = f68e0b0045f43c103be6827c166fa503 OK 2025/07/05 07:30:34 DEBUG : enormous: Excluded (Size Filter) 2025/07/05 07:30:34 DEBUG : enormous: Excluded 2025/07/05 07:30:34 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 07:30:34 DEBUG : potato2: Excluded 2025/07/05 07:30:34 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 07:30:34 DEBUG : potato2: Excluded 2025/07/05 07:30:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:30:40 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:30:40 DEBUG : empty space: Unchanged skipping 2025/07/05 07:30:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:30:40 DEBUG : Waiting for deletions to finish 2025/07/05 07:30:40 INFO : There was nothing to transfer 2025/07/05 07:30:45 DEBUG : enormous: Excluded (Size Filter) 2025/07/05 07:30:45 DEBUG : enormous: Excluded 2025/07/05 07:30:45 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 07:30:45 DEBUG : potato2: Excluded 2025/07/05 07:30:45 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 07:30:45 DEBUG : potato2: Excluded 2025/07/05 07:30:45 DEBUG : Local file system at /tmp/rclone2770026733: Waiting for checks to finish 2025/07/05 07:30:45 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:30:45 DEBUG : empty space: Unchanged skipping 2025/07/05 07:30:45 DEBUG : Local file system at /tmp/rclone2770026733: Waiting for transfers to finish 2025/07/05 07:30:45 DEBUG : Waiting for deletions to finish 2025/07/05 07:30:45 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (41.41s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:31:05 DEBUG : potato2: md5 = bee531e40eb543d8edb297404044870c OK 2025/07/05 07:31:11 DEBUG : empty space: md5 = 8aed9273c8acdd66f0657a419e72fd23 OK 2025/07/05 07:31:16 DEBUG : enormous: md5 = 0fa4027364e6ccfed64093941e29bb0c OK 2025/07/05 07:31:21 DEBUG : enormous: Excluded (Size Filter) 2025/07/05 07:31:21 DEBUG : enormous: Excluded 2025/07/05 07:31:21 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 07:31:21 DEBUG : potato2: Excluded 2025/07/05 07:31:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:31:21 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:31:21 DEBUG : empty space: Unchanged skipping 2025/07/05 07:31:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:31:21 DEBUG : Waiting for deletions to finish 2025/07/05 07:31:26 INFO : potato2: Deleted 2025/07/05 07:31:31 INFO : enormous: Deleted 2025/07/05 07:31:31 INFO : There was nothing to transfer 2025/07/05 07:31:32 DEBUG : Local file system at /tmp/rclone2770026733: Waiting for checks to finish 2025/07/05 07:31:37 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:31:37 DEBUG : empty space: Unchanged skipping 2025/07/05 07:31:37 DEBUG : Local file system at /tmp/rclone2770026733: Waiting for transfers to finish 2025/07/05 07:31:37 DEBUG : Waiting for deletions to finish 2025/07/05 07:31:37 INFO : enormous: Deleted 2025/07/05 07:31:37 INFO : potato2: Deleted 2025/07/05 07:31:37 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (41.80s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:31:47 DEBUG : one: md5 = 19f8210f69f42a2a9a964997ece16560 OK 2025/07/05 07:31:48 DEBUG : two: md5 = 621fd4cd4ca3982064168141a08d5338 OK 2025/07/05 07:31:48 DEBUG : three: md5 = 6eee42219a9a55d939f03b930bad3a7f OK 2025/07/05 07:31:53 DEBUG : four: md5 = 43a0d142b01279391b3b655f2d163f3a OK 2025/07/05 07:31:59 DEBUG : five: Need to transfer - File not found at Destination 2025/07/05 07:31:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:31:59 DEBUG : one: Destination is newer than source, skipping 2025/07/05 07:31:59 DEBUG : three: Sizes identical 2025/07/05 07:31:59 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/07/05 07:31:59 DEBUG : two: md5 = 040b8909c67c7efed6ce29c7c5264f34 OK 2025/07/05 07:31:59 INFO : two: Copied (replaced existing) 2025/07/05 07:32:04 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/07/05 07:32:04 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/07/05 07:32:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:32:04 DEBUG : five: md5 = 7afb4f5adf3d6ffdac6b7664465318e4 OK 2025/07/05 07:32:04 INFO : five: Copied (new) 2025/07/05 07:32:09 DEBUG : four: md5 = d9f73f6e915de1a7d395f3cc79bc2805 OK 2025/07/05 07:32:09 INFO : four: Copied (replaced existing) 2025/07/05 07:32:09 DEBUG : Waiting for deletions to finish sync_test.go:1479: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (48.34s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1496: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1496: 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-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:1568: Can track renames: false 2025/07/05 07:32:30 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Ignoring --track-renames as the source and destination do not have a common hash 2025/07/05 07:32:30 DEBUG : potato: Need to transfer - File not found at Destination 2025/07/05 07:32:30 DEBUG : yam: Need to transfer - File not found at Destination 2025/07/05 07:32:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:32:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:32:31 DEBUG : potato: md5 = 38936f6a5dd294d8312921c1f9e3a755 OK 2025/07/05 07:32:31 INFO : potato: Copied (new) 2025/07/05 07:32:36 DEBUG : yam: md5 = 050c1f3cc0fb2d4d59482b455364477c OK 2025/07/05 07:32:36 INFO : yam: Copied (new) 2025/07/05 07:32:36 DEBUG : Waiting for deletions to finish 2025/07/05 07:32:36 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Ignoring --track-renames as the source and destination do not have a common hash 2025/07/05 07:32:36 DEBUG : yaml: Need to transfer - File not found at Destination 2025/07/05 07:32:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:32:36 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:32:36 DEBUG : potato: Unchanged skipping 2025/07/05 07:32:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:32:37 DEBUG : yaml: md5 = 89708fc682b3832ed52d210eac4aa6a7 OK 2025/07/05 07:32:37 INFO : yaml: Copied (new) 2025/07/05 07:32:37 DEBUG : Waiting for deletions to finish 2025/07/05 07:32:42 INFO : yam: Deleted --- PASS: TestSyncWithTrackRenames (12.56s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:1640: Can track renames: true 2025/07/05 07:32:43 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Making map for --track-renames 2025/07/05 07:32:43 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Finished making map for --track-renames 2025/07/05 07:32:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:32:43 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/05 07:32:43 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/05 07:32:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for renames to finish 2025/07/05 07:32:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:32:43 DEBUG : potato: md5 = ada134270f2f7e2b84cfb81307c71d62 OK 2025/07/05 07:32:43 INFO : potato: Copied (new) 2025/07/05 07:32:48 DEBUG : yam: md5 = 5836cc903e1b458d84c2568deac7419b OK 2025/07/05 07:32:48 INFO : yam: Copied (new) 2025/07/05 07:32:48 DEBUG : Waiting for deletions to finish 2025/07/05 07:32:49 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Making map for --track-renames 2025/07/05 07:32:49 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Finished making map for --track-renames 2025/07/05 07:32:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:32:49 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:32:49 DEBUG : potato: Unchanged skipping 2025/07/05 07:32:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for renames to finish 2025/07/05 07:32:59 INFO : yam: Copied (server-side copy) to: yaml 2025/07/05 07:33:04 INFO : yam: Deleted 2025/07/05 07:33:04 INFO : yaml: Renamed from "yam" 2025/07/05 07:33:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:33:04 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (22.57s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:1679: Can track renames: true 2025/07/05 07:33:06 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Making map for --track-renames 2025/07/05 07:33:06 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Finished making map for --track-renames 2025/07/05 07:33:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:33:06 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/05 07:33:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for renames to finish 2025/07/05 07:33:06 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/07/05 07:33:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:33:06 DEBUG : potato: md5 = f3a57679cfd3409ef94d828dfa0629cc OK 2025/07/05 07:33:06 INFO : potato: Copied (new) 2025/07/05 07:33:11 DEBUG : sub/yam: md5 = 440a91eb929016a49aec4e941a1efdfc OK 2025/07/05 07:33:11 INFO : sub/yam: Copied (new) 2025/07/05 07:33:11 DEBUG : Waiting for deletions to finish 2025/07/05 07:33:11 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:33:11 DEBUG : potato: Unchanged skipping 2025/07/05 07:33:11 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Making map for --track-renames 2025/07/05 07:33:11 INFO : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Finished making map for --track-renames 2025/07/05 07:33:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:33:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for renames to finish 2025/07/05 07:33:27 INFO : sub/yam: Copied (server-side copy) to: yam 2025/07/05 07:33:32 INFO : sub/yam: Deleted 2025/07/05 07:33:32 INFO : yam: Renamed from "sub/yam" 2025/07/05 07:33:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:33:32 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (32.44s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:33:38 DEBUG : Creating backend with remote "/tmp/rclone2770026733/dir1" 2025/07/05 07:33:38 DEBUG : Creating backend with remote "/tmp/rclone2770026733/dir2" 2025/07/05 07:33:38 DEBUG : Local file system at /tmp/rclone2770026733/dir2: Using server-side directory move 2025/07/05 07:33:38 INFO : Local file system at /tmp/rclone2770026733/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/05 07:33:38 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/07/05 07:33:38 DEBUG : Local file system at /tmp/rclone2770026733/dir2: Waiting for checks to finish 2025/07/05 07:33:38 DEBUG : Local file system at /tmp/rclone2770026733/dir2: Waiting for transfers to finish 2025/07/05 07:33:38 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.24s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:33:38 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:33:38 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/05 07:33:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:33:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:33:43 DEBUG : sub dir/hello world: md5 = 46e8a22e311056da3142e4ba83da8294 OK 2025/07/05 07:33:43 INFO : sub dir/hello world: Copied (new) 2025/07/05 07:33:43 INFO : sub dir/hello world: Deleted 2025/07/05 07:33:44 DEBUG : nested/sub dir/file: md5 = 3736eb9fc54b32b19302ff5c6e44b102 OK 2025/07/05 07:33:44 INFO : nested/sub dir/file: Copied (new) 2025/07/05 07:33:44 INFO : nested/sub dir/file: Deleted 2025/07/05 07:33:44 INFO : sub dir: Removing directory 2025/07/05 07:33:44 INFO : nested/sub dir: Removing directory 2025/07/05 07:33:44 INFO : nested: Removing directory 2025/07/05 07:33:44 DEBUG : Local file system at /tmp/rclone2770026733: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (26.18s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:34:04 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 07:34:04 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/05 07:34:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:34:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:34:09 DEBUG : sub dir/hello world: md5 = a2914dae0d30edfbd00910cbc4f39d70 OK 2025/07/05 07:34:09 INFO : sub dir/hello world: Copied (new) 2025/07/05 07:34:10 INFO : sub dir/hello world: Deleted 2025/07/05 07:34:10 DEBUG : nested/sub dir/file: md5 = 3b0bc141a6cdb93df6d12d494629cac2 OK 2025/07/05 07:34:10 INFO : nested/sub dir/file: Copied (new) 2025/07/05 07:34:10 INFO : nested/sub dir/file: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (21.08s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:34:26 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/07/05 07:34:26 DEBUG : existing: Need to transfer - File not found at Destination 2025/07/05 07:34:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:34:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:34:26 DEBUG : existing-b: md5 = 991a514a0e27bc150cff393670d2c0cc OK 2025/07/05 07:34:26 INFO : existing-b: Copied (new) 2025/07/05 07:34:26 INFO : existing-b: Deleted 2025/07/05 07:34:31 DEBUG : existing: md5 = 0f1bf79ec68a4d4d368771c4d043a9a0 OK 2025/07/05 07:34:31 INFO : existing: Copied (new) 2025/07/05 07:34:31 INFO : existing: Deleted 2025/07/05 07:34:36 DEBUG : existing: Destination exists, skipping 2025/07/05 07:34:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:34:41 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/07/05 07:34:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:34:41 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (26.95s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:34:52 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-roniwag0jike" 2025/07/05 07:34:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-roniwag0jike.bin" 2025/07/05 07:34:53 DEBUG : Swift container crypt path rclone-test-roniwag0jike.bin: Auto set use_segments_container to true 2025/07/05 07:34:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-roniwag0jike" 2025/07/05 07:34:58 DEBUG : Swift container crypt path rclone-test-roniwag0jike: Auto set use_segments_container to true 2025/07/05 07:35:09 DEBUG : potato2: md5 = 02215cf6e543836bdfc2d8ec6aaa0de0 OK 2025/07/05 07:35:14 DEBUG : empty space: md5 = e11333341e3bddb89530f785e37c0b3c OK 2025/07/05 07:35:19 DEBUG : potato3: md5 = 15fd3185d7b9b003271013d46b05ad7b OK sync_test.go:1735: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe' -> Encrypted drive 'TestCryptSwift:rclone-test-roniwag0jike' 2025/07/05 07:35:30 DEBUG : empty space: md5 = e95c433637ed2deb92ecb0c67b380b8b OK 2025/07/05 07:35:31 DEBUG : potato3: md5 = fb46309eef51a2625f75bcf19164328e OK 2025/07/05 07:35:36 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:35:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-roniwag0jike': Waiting for checks to finish 2025/07/05 07:35:36 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/05 07:35:36 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:35:36 DEBUG : empty space: Unchanged skipping 2025/07/05 07:35:41 INFO : empty space: Deleted 2025/07/05 07:35:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-roniwag0jike': Waiting for transfers to finish 2025/07/05 07:35:42 INFO : potato3: Copied (server-side copy) 2025/07/05 07:35:42 INFO : potato2: Copied (server-side copy) 2025/07/05 07:35:47 INFO : potato3: Deleted 2025/07/05 07:35:47 INFO : potato2: Deleted 2025/07/05 07:35:47 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-lolecud2biqa" 2025/07/05 07:35:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-lolecud2biqa.bin" 2025/07/05 07:35:48 DEBUG : Swift container crypt path rclone-test-lolecud2biqa.bin: Auto set use_segments_container to true 2025/07/05 07:35:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-lolecud2biqa" 2025/07/05 07:35:53 DEBUG : Swift container crypt path rclone-test-lolecud2biqa: Auto set use_segments_container to true 2025/07/05 07:35:59 DEBUG : empty space: Need to transfer - File not found at Destination 2025/07/05 07:35:59 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:35:59 DEBUG : potato3: Need to transfer - File not found at Destination 2025/07/05 07:35:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-lolecud2biqa': Waiting for checks to finish 2025/07/05 07:35:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-lolecud2biqa': Waiting for transfers to finish 2025/07/05 07:36:04 INFO : potato3: Copied (server-side copy) 2025/07/05 07:36:05 INFO : potato2: Copied (server-side copy) 2025/07/05 07:36:05 INFO : potato2: Deleted 2025/07/05 07:36:05 INFO : potato3: Deleted 2025/07/05 07:36:14 INFO : empty space: Copied (server-side copy) 2025/07/05 07:36:19 INFO : empty space: Deleted 2025/07/05 07:36:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-lolecud2biqa': Purge remote 2025/07/05 07:36:20 DEBUG : Waiting for deletions to finish 2025/07/05 07:36:20 INFO : potato3.bin: Deleted 2025/07/05 07:36:20 INFO : potato2.bin: Deleted 2025/07/05 07:36:30 INFO : empty space.bin: Deleted 2025/07/05 07:36:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-roniwag0jike': Purge remote 2025/07/05 07:36:30 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (98.29s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:36:31 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-fuhoxoz9tulu" 2025/07/05 07:36:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fuhoxoz9tulu.bin" 2025/07/05 07:36:31 DEBUG : Swift container crypt path rclone-test-fuhoxoz9tulu.bin: Auto set use_segments_container to true 2025/07/05 07:36:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fuhoxoz9tulu" 2025/07/05 07:36:37 DEBUG : Swift container crypt path rclone-test-fuhoxoz9tulu: Auto set use_segments_container to true 2025/07/05 07:36:47 DEBUG : potato2: md5 = 36b85a21619eb070e70ebc2254238aeb OK 2025/07/05 07:36:52 DEBUG : empty space: md5 = f83f21be896133b989533d46ba46d70b OK 2025/07/05 07:36:58 DEBUG : potato3: md5 = 3ebef87dfe07ceddb817b758d0c45cff OK sync_test.go:1735: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe' -> Encrypted drive 'TestCryptSwift:rclone-test-fuhoxoz9tulu' 2025/07/05 07:37:03 DEBUG : empty space: md5 = 7ed86df4d0303edb94084ce54dfedd23 OK 2025/07/05 07:37:04 DEBUG : potato3: md5 = 681f19395ae4cb56ae4835469f9113c6 OK 2025/07/05 07:37:04 DEBUG : empty space: Excluded (Size Filter) 2025/07/05 07:37:04 DEBUG : empty space: Excluded 2025/07/05 07:37:04 DEBUG : empty space: Excluded (Size Filter) 2025/07/05 07:37:04 DEBUG : empty space: Excluded 2025/07/05 07:37:04 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:37:04 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/05 07:37:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fuhoxoz9tulu': Waiting for checks to finish 2025/07/05 07:37:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fuhoxoz9tulu': Waiting for transfers to finish 2025/07/05 07:37:10 INFO : potato2: Copied (server-side copy) 2025/07/05 07:37:15 INFO : potato3: Copied (server-side copy) 2025/07/05 07:37:15 INFO : potato2: Deleted 2025/07/05 07:37:20 INFO : potato3: Deleted 2025/07/05 07:37:25 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-caloyah8yuzu" 2025/07/05 07:37:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-caloyah8yuzu.bin" 2025/07/05 07:37:25 DEBUG : Swift container crypt path rclone-test-caloyah8yuzu.bin: Auto set use_segments_container to true 2025/07/05 07:37:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-caloyah8yuzu" 2025/07/05 07:37:31 DEBUG : Swift container crypt path rclone-test-caloyah8yuzu: Auto set use_segments_container to true 2025/07/05 07:37:37 DEBUG : empty space: Excluded (Size Filter) 2025/07/05 07:37:37 DEBUG : empty space: Excluded 2025/07/05 07:37:37 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:37:37 DEBUG : potato3: Need to transfer - File not found at Destination 2025/07/05 07:37:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-caloyah8yuzu': Waiting for checks to finish 2025/07/05 07:37:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-caloyah8yuzu': Waiting for transfers to finish 2025/07/05 07:37:42 INFO : potato2: Copied (server-side copy) 2025/07/05 07:37:42 INFO : potato2: Deleted 2025/07/05 07:37:43 INFO : potato3: Copied (server-side copy) 2025/07/05 07:37:43 INFO : potato3: Deleted 2025/07/05 07:37:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-caloyah8yuzu': Purge remote 2025/07/05 07:37:48 DEBUG : Waiting for deletions to finish 2025/07/05 07:37:49 INFO : potato2.bin: Deleted 2025/07/05 07:37:49 INFO : potato3.bin: Deleted 2025/07/05 07:37:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fuhoxoz9tulu': Purge remote 2025/07/05 07:37:49 DEBUG : Waiting for deletions to finish 2025/07/05 07:37:59 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (93.79s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:38:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qiwizec8rugu" 2025/07/05 07:38:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qiwizec8rugu.bin" 2025/07/05 07:38:05 DEBUG : Swift container crypt path rclone-test-qiwizec8rugu.bin: Auto set use_segments_container to true 2025/07/05 07:38:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qiwizec8rugu" 2025/07/05 07:38:10 DEBUG : Swift container crypt path rclone-test-qiwizec8rugu: Auto set use_segments_container to true 2025/07/05 07:38:21 DEBUG : potato2: md5 = d5ea722cac80047c51afdf8ae5c465ee OK 2025/07/05 07:38:26 DEBUG : empty space: md5 = 6479bbf25ec4987e56c2fdbcfd024e13 OK 2025/07/05 07:38:31 DEBUG : potato3: md5 = 7b87507a9018359eecfcd33382487445 OK 2025/07/05 07:38:31 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe' -> Encrypted drive 'TestCryptSwift:rclone-test-qiwizec8rugu' 2025/07/05 07:38:37 DEBUG : empty space: md5 = d547dbbb91354bee0ec3c3cdf335966b OK 2025/07/05 07:38:43 DEBUG : potato3: md5 = ba8077334981453e4eaf91083c2d12e1 OK 2025/07/05 07:38:43 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:38:43 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/05 07:38:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qiwizec8rugu': Waiting for checks to finish 2025/07/05 07:38:43 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:38:43 DEBUG : empty space: Unchanged skipping 2025/07/05 07:38:48 INFO : empty space: Deleted 2025/07/05 07:38:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qiwizec8rugu': Waiting for transfers to finish 2025/07/05 07:38:49 INFO : potato2: Copied (server-side copy) 2025/07/05 07:38:54 INFO : potato2: Deleted 2025/07/05 07:38:59 INFO : potato3: Copied (server-side copy) 2025/07/05 07:39:04 INFO : potato3: Deleted 2025/07/05 07:39:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-woxocok5fehe" 2025/07/05 07:39:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-woxocok5fehe.bin" 2025/07/05 07:39:10 DEBUG : Swift container crypt path rclone-test-woxocok5fehe.bin: Auto set use_segments_container to true 2025/07/05 07:39:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-woxocok5fehe" 2025/07/05 07:39:15 DEBUG : Swift container crypt path rclone-test-woxocok5fehe: Auto set use_segments_container to true 2025/07/05 07:39:21 INFO : tomatoDir: Making directory 2025/07/05 07:39:21 DEBUG : empty space: Need to transfer - File not found at Destination 2025/07/05 07:39:21 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 07:39:21 DEBUG : potato3: Need to transfer - File not found at Destination 2025/07/05 07:39:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-woxocok5fehe': Waiting for checks to finish 2025/07/05 07:39:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-woxocok5fehe': Waiting for transfers to finish 2025/07/05 07:39:31 INFO : empty space: Copied (server-side copy) 2025/07/05 07:39:32 INFO : empty space: Deleted 2025/07/05 07:39:32 INFO : potato2: Copied (server-side copy) 2025/07/05 07:39:32 INFO : potato2: Deleted 2025/07/05 07:39:33 INFO : potato3: Copied (server-side copy) 2025/07/05 07:39:38 INFO : potato3: Deleted 2025/07/05 07:39:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-woxocok5fehe': Purge remote 2025/07/05 07:39:39 DEBUG : Waiting for deletions to finish 2025/07/05 07:39:39 INFO : potato3.bin: Deleted 2025/07/05 07:39:44 INFO : empty space.bin: Deleted 2025/07/05 07:39:44 INFO : potato2.bin: Deleted 2025/07/05 07:39:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qiwizec8rugu': Purge remote 2025/07/05 07:39:44 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (99.88s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:39:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/rclone-move-test" 2025/07/05 07:39:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-move-test.bin" 2025/07/05 07:39:45 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-move-test.bin: Auto set use_segments_container to true 2025/07/05 07:39:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-move-test" 2025/07/05 07:39:51 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-move-test: Auto set use_segments_container to true 2025/07/05 07:40:01 DEBUG : potato2: md5 = ee10956c37e59849eee9818ca5323f90 OK --- PASS: TestServerSideMoveOverlap (22.64s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:40:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test" 2025/07/05 07:40:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-sync-test.bin" 2025/07/05 07:40:07 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-sync-test.bin: Auto set use_segments_container to true 2025/07/05 07:40:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-sync-test" 2025/07/05 07:40:13 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-sync-test: Auto set use_segments_container to true --- PASS: TestSyncOverlap (11.54s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:40:18 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test" 2025/07/05 07:40:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-sync-test.bin" 2025/07/05 07:40:19 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-sync-test.bin: Auto set use_segments_container to true 2025/07/05 07:40:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-sync-test" 2025/07/05 07:40:24 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-sync-test: Auto set use_segments_container to true 2025/07/05 07:40:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test-include/layer2" 2025/07/05 07:40:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-sync-test-include/layer2.bin" 2025/07/05 07:40:45 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/07/05 07:40:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-sync-test-include/layer2" 2025/07/05 07:40:51 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/07/05 07:41:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test-ignore-file" 2025/07/05 07:41:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-sync-test-ignore-file.bin" 2025/07/05 07:41:12 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/07/05 07:41:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/rclone-sync-test-ignore-file" 2025/07/05 07:41:32 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/07/05 07:41:38 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = d86b21e197dc14d861fc5af0e585584f OK 2025/07/05 07:41:45 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 07:41:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test': Waiting for checks to finish 2025/07/05 07:41:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test': Waiting for transfers to finish 2025/07/05 07:41:45 DEBUG : Waiting for deletions to finish 2025/07/05 07:41:45 INFO : There was nothing to transfer 2025/07/05 07:41:50 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 07:41:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:41:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:41:50 DEBUG : Waiting for deletions to finish 2025/07/05 07:41:50 INFO : There was nothing to transfer 2025/07/05 07:41:55 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 07:41:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/07/05 07:41:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/07/05 07:41:55 DEBUG : Waiting for deletions to finish 2025/07/05 07:41:55 INFO : There was nothing to transfer 2025/07/05 07:42:00 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 07:42:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 07:42:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 07:42:00 DEBUG : Waiting for deletions to finish 2025/07/05 07:42:00 INFO : There was nothing to transfer 2025/07/05 07:42:00 DEBUG : Excluded 2025/07/05 07:42:01 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 07:42:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/07/05 07:42:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/07/05 07:42:01 DEBUG : Waiting for deletions to finish 2025/07/05 07:42:01 INFO : There was nothing to transfer --- PASS: TestSyncOverlapWithFilter (102.39s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:42:01 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/dst" 2025/07/05 07:42:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst.bin" 2025/07/05 07:42:01 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst.bin: Auto set use_segments_container to true 2025/07/05 07:42:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst" 2025/07/05 07:42:07 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst: Auto set use_segments_container to true 2025/07/05 07:42:12 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/CompareDest" 2025/07/05 07:42:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/CompareDest.bin" 2025/07/05 07:42:13 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/CompareDest.bin: Auto set use_segments_container to true 2025/07/05 07:42:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/CompareDest" 2025/07/05 07:42:18 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/CompareDest: Auto set use_segments_container to true 2025/07/05 07:42:29 DEBUG : one: Need to transfer - File not found at Destination 2025/07/05 07:42:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:42:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:42:34 DEBUG : one: md5 = be42bb16a1fdc689d053d441038f552e OK 2025/07/05 07:42:34 INFO : one: Copied (new) 2025/07/05 07:42:34 DEBUG : Waiting for deletions to finish 2025/07/05 07:42:35 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 07:42:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:42:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:42:50 DEBUG : one: md5 = d78980f46d340b5a294ebd0c25d00738 OK 2025/07/05 07:42:50 INFO : one: Copied (replaced existing) 2025/07/05 07:42:50 DEBUG : Waiting for deletions to finish 2025/07/05 07:43:00 DEBUG : dst/one: md5 = 293fdab0df6f15bfc63e1827281947e9 OK 2025/07/05 07:43:01 DEBUG : CompareDest/one: md5 = 4396b35c017e04bb1ff013dfe0f939f1 OK 2025/07/05 07:43:01 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 07:43:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:43:01 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:43:01 DEBUG : one: Destination found in --compare-dest, skipping 2025/07/05 07:43:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:43:01 DEBUG : Waiting for deletions to finish 2025/07/05 07:43:01 INFO : There was nothing to transfer 2025/07/05 07:43:02 DEBUG : CompareDest/two: md5 = 97a3194181022dd37dd20508f90e1668 OK 2025/07/05 07:43:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 07:43:02 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:43:02 DEBUG : two: Destination found in --compare-dest, skipping 2025/07/05 07:43:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:43:02 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:43:02 DEBUG : one: Destination found in --compare-dest, skipping 2025/07/05 07:43:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:43:02 DEBUG : Waiting for deletions to finish 2025/07/05 07:43:02 INFO : There was nothing to transfer 2025/07/05 07:43:03 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 07:43:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:43:03 DEBUG : two: Destination found in --compare-dest, skipping 2025/07/05 07:43:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:43:03 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:43:03 DEBUG : one: Destination found in --compare-dest, skipping 2025/07/05 07:43:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:43:03 DEBUG : Waiting for deletions to finish 2025/07/05 07:43:03 INFO : There was nothing to transfer sync_test.go:2205: No hash on uploaded file so skipping compare timestamp test 2025/07/05 07:43:08 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 07:43:08 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:43:08 DEBUG : one: Destination found in --compare-dest, skipping 2025/07/05 07:43:08 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/07/05 07:43:08 DEBUG : two: Need to transfer - File not found at Destination 2025/07/05 07:43:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:43:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:43:09 DEBUG : two: md5 = 99d8e4dab7920865788e9ffb94ba44fc OK 2025/07/05 07:43:09 INFO : two: Copied (new) 2025/07/05 07:43:09 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (74.12s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:43:20 DEBUG : pre-dest1/1: md5 = 5ac6889e84d90f85cbec4f8bf5d1bd4c OK 2025/07/05 07:43:21 DEBUG : pre-dest2/2: md5 = 57cd0ba3a3c29b66c47ec465d70a9f94 OK 2025/07/05 07:43:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/dest" 2025/07/05 07:43:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dest.bin" 2025/07/05 07:43:21 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dest.bin: Auto set use_segments_container to true 2025/07/05 07:43:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dest" 2025/07/05 07:43:30 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dest: Auto set use_segments_container to true 2025/07/05 07:43:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/pre-dest1" 2025/07/05 07:43:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/pre-dest1.bin" 2025/07/05 07:43:36 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/pre-dest1.bin: Auto set use_segments_container to true 2025/07/05 07:43:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/pre-dest1" 2025/07/05 07:43:57 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/pre-dest1: Auto set use_segments_container to true 2025/07/05 07:44:02 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/pre-dest2" 2025/07/05 07:44:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/pre-dest2.bin" 2025/07/05 07:44:02 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/pre-dest2.bin: Auto set use_segments_container to true 2025/07/05 07:44:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/pre-dest2" 2025/07/05 07:44:08 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/pre-dest2: Auto set use_segments_container to true 2025/07/05 07:44:19 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:44:19 DEBUG : 1: Destination found in --compare-dest, skipping 2025/07/05 07:44:24 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:44:24 DEBUG : 2: Destination found in --compare-dest, skipping 2025/07/05 07:44:34 DEBUG : 3: Need to transfer - File not found at Destination 2025/07/05 07:44:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dest': Waiting for checks to finish 2025/07/05 07:44:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dest': Waiting for transfers to finish 2025/07/05 07:44:40 DEBUG : 3: md5 = 4aa4f7ee988bb2a0f2175712f596e48f OK 2025/07/05 07:44:40 INFO : 3: Copied (new) 2025/07/05 07:44:40 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (116.05s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:45:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/dst" 2025/07/05 07:45:11 DEBUG : Config file has changed externally - reloading 2025/07/05 07:45:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst.bin" 2025/07/05 07:45:11 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst.bin: Auto set use_segments_container to true 2025/07/05 07:45:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst" 2025/07/05 07:45:17 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst: Auto set use_segments_container to true 2025/07/05 07:45:22 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/CopyDest" 2025/07/05 07:45:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/CopyDest.bin" 2025/07/05 07:45:23 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/CopyDest.bin: Auto set use_segments_container to true 2025/07/05 07:45:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/CopyDest" 2025/07/05 07:45:28 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/CopyDest: Auto set use_segments_container to true 2025/07/05 07:45:39 DEBUG : one: Need to transfer - File not found at Destination 2025/07/05 07:45:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:45:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:45:44 DEBUG : one: md5 = 6321d3ee7a5319fd394f8f5a7d363f33 OK 2025/07/05 07:45:44 INFO : one: Copied (new) 2025/07/05 07:45:44 DEBUG : Waiting for deletions to finish 2025/07/05 07:45:49 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 07:45:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:45:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:46:00 DEBUG : one: md5 = ca6bd234f20395efaba6a27e0b056165 OK 2025/07/05 07:46:00 INFO : one: Copied (replaced existing) 2025/07/05 07:46:00 DEBUG : Waiting for deletions to finish 2025/07/05 07:46:05 DEBUG : dst/one: md5 = e6a598a216f386f42090255c3a7940b5 OK 2025/07/05 07:46:14 DEBUG : CopyDest/one: md5 = 5b0db78b08e44bd50a551d639f60d4f3 OK 2025/07/05 07:46:19 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/BackupDir" 2025/07/05 07:46:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/BackupDir.bin" 2025/07/05 07:46:20 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/BackupDir.bin: Auto set use_segments_container to true 2025/07/05 07:46:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/BackupDir" 2025/07/05 07:46:25 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/BackupDir: Auto set use_segments_container to true 2025/07/05 07:46:31 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 07:46:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:46:31 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:46:31 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 07:46:52 INFO : one: Copied (server-side copy) 2025/07/05 07:46:57 INFO : one: Deleted 2025/07/05 07:47:12 INFO : one: Copied (server-side copy) 2025/07/05 07:47:12 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/07/05 07:47:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:47:12 DEBUG : Waiting for deletions to finish 2025/07/05 07:47:23 DEBUG : CopyDest/two: md5 = 312ae1d596a6098632ceedea55c48800 OK 2025/07/05 07:47:29 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:47:34 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:47:34 DEBUG : one: Unchanged skipping 2025/07/05 07:47:34 INFO : two: Copied (server-side copy) 2025/07/05 07:47:34 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/07/05 07:47:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:47:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:47:34 DEBUG : Waiting for deletions to finish 2025/07/05 07:47:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:47:34 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:47:34 DEBUG : two: Unchanged skipping 2025/07/05 07:47:39 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:47:39 DEBUG : one: Unchanged skipping 2025/07/05 07:47:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:47:39 DEBUG : Waiting for deletions to finish 2025/07/05 07:47:39 INFO : There was nothing to transfer 2025/07/05 07:47:50 DEBUG : CopyDest/three: md5 = ae94432007d5108085e715e259c1d5b2 OK 2025/07/05 07:47:51 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/07/05 07:47:51 DEBUG : three: Destination not found in --copy-dest 2025/07/05 07:47:51 DEBUG : three: Need to transfer - File not found at Destination 2025/07/05 07:47:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:47:51 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:47:51 DEBUG : two: Unchanged skipping 2025/07/05 07:47:51 DEBUG : three: md5 = 5b2de3f1f0d17087d4c9feadb07d6c8e OK 2025/07/05 07:47:51 INFO : three: Copied (new) 2025/07/05 07:47:56 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:47:56 DEBUG : one: Unchanged skipping 2025/07/05 07:47:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:47:56 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (196.57s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:48:33 DEBUG : dst/one: md5 = 984c2db61a3fac765146df214aa37fec OK 2025/07/05 07:48:33 DEBUG : dst/two: md5 = 5be59c68e7b1c7ece22a1f6a10bddf1e OK 2025/07/05 07:48:39 DEBUG : dst/three.txt: md5 = ce672c46e7674b1664ac057dd97bada7 OK 2025/07/05 07:48:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/dst" 2025/07/05 07:48:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst.bin" 2025/07/05 07:48:44 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst.bin: Auto set use_segments_container to true 2025/07/05 07:48:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst" 2025/07/05 07:48:50 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst: Auto set use_segments_container to true 2025/07/05 07:48:55 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/backup" 2025/07/05 07:48:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/backup.bin" 2025/07/05 07:48:55 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/backup.bin: Auto set use_segments_container to true 2025/07/05 07:49:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/backup" 2025/07/05 07:49:01 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/backup: Auto set use_segments_container to true 2025/07/05 07:49:06 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 07:49:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:49:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:49:07 DEBUG : two: Unchanged skipping 2025/07/05 07:49:17 INFO : one: Copied (server-side copy) 2025/07/05 07:49:22 INFO : one: Deleted 2025/07/05 07:49:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:49:27 DEBUG : one: md5 = 33def72ae845dc89aac31ff909947fd2 OK 2025/07/05 07:49:27 INFO : one: Copied (new) 2025/07/05 07:49:27 DEBUG : Waiting for deletions to finish 2025/07/05 07:49:48 INFO : three.txt: Copied (server-side copy) 2025/07/05 07:49:53 INFO : three.txt: Deleted 2025/07/05 07:49:53 INFO : three.txt: Moved into backup dir 2025/07/05 07:50:04 DEBUG : dst/three.txt: md5 = 46b4f2f172b30150baec7b017de802bd OK 2025/07/05 07:50:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:50:04 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 07:50:05 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:50:05 DEBUG : two: Unchanged skipping 2025/07/05 07:50:10 INFO : one: Copied (server-side copy) 2025/07/05 07:50:15 INFO : one: Deleted 2025/07/05 07:50:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:50:20 DEBUG : one: md5 = 53f6227b9eeb2101bfb551eba656e4b3 OK 2025/07/05 07:50:20 INFO : one: Copied (new) 2025/07/05 07:50:20 DEBUG : Waiting for deletions to finish 2025/07/05 07:50:35 INFO : three.txt: Copied (server-side copy) 2025/07/05 07:50:41 INFO : three.txt: Deleted 2025/07/05 07:50:41 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (144.00s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:50:57 DEBUG : dst/one: md5 = b8c0eae647126e31c88d933b08d4e0aa OK 2025/07/05 07:50:57 DEBUG : dst/two: md5 = ad0e2735a45b6de33ce16e74c34c4bfe OK 2025/07/05 07:51:02 DEBUG : dst/three.txt: md5 = d70951abbd7aba38c2bb4b6b4c108810 OK 2025/07/05 07:51:02 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/dst" 2025/07/05 07:51:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst.bin" 2025/07/05 07:51:03 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst.bin: Auto set use_segments_container to true 2025/07/05 07:51:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst" 2025/07/05 07:51:08 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst: Auto set use_segments_container to true 2025/07/05 07:51:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/backup" 2025/07/05 07:51:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/backup.bin" 2025/07/05 07:51:14 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/backup.bin: Auto set use_segments_container to true 2025/07/05 07:51:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/backup" 2025/07/05 07:51:19 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/backup: Auto set use_segments_container to true 2025/07/05 07:51:25 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 07:51:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:51:25 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:51:25 DEBUG : two: Unchanged skipping 2025/07/05 07:51:40 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 07:51:45 INFO : one: Deleted 2025/07/05 07:51:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:51:51 DEBUG : one: md5 = feda88f16ac1bffac77afb119416b21c OK 2025/07/05 07:51:51 INFO : one: Copied (new) 2025/07/05 07:51:51 DEBUG : Waiting for deletions to finish 2025/07/05 07:52:02 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 07:52:07 INFO : three.txt: Deleted 2025/07/05 07:52:07 INFO : three.txt: Moved into backup dir 2025/07/05 07:52:13 DEBUG : dst/three.txt: md5 = e7a3c5e2c663cd81c12cb70d74d3f7e5 OK 2025/07/05 07:52:18 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 07:52:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:52:18 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:52:18 DEBUG : two: Unchanged skipping 2025/07/05 07:52:28 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 07:52:33 INFO : one: Deleted 2025/07/05 07:52:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:52:39 DEBUG : one: md5 = 07c3b7767cbb5f10a4783b99acbee517 OK 2025/07/05 07:52:39 INFO : one: Copied (new) 2025/07/05 07:52:39 DEBUG : Waiting for deletions to finish 2025/07/05 07:52:44 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 07:52:49 INFO : three.txt: Deleted 2025/07/05 07:52:49 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (133.75s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:53:11 DEBUG : dst/one: md5 = 71eb5691ad83cfc57a5df75f4a299251 OK 2025/07/05 07:53:11 DEBUG : dst/two: md5 = 6feed35d8d7a318ddc0219a66049fe7a OK 2025/07/05 07:53:16 DEBUG : dst/three.txt: md5 = 88258ab8b992f3dc3e4fb1faefe39461 OK 2025/07/05 07:53:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/dst" 2025/07/05 07:53:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst.bin" 2025/07/05 07:53:22 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst.bin: Auto set use_segments_container to true 2025/07/05 07:53:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst" 2025/07/05 07:53:27 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst: Auto set use_segments_container to true 2025/07/05 07:53:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/backup" 2025/07/05 07:53:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/backup.bin" 2025/07/05 07:53:33 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/backup.bin: Auto set use_segments_container to true 2025/07/05 07:53:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/backup" 2025/07/05 07:53:38 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/backup: Auto set use_segments_container to true 2025/07/05 07:53:44 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 07:53:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:53:44 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:53:44 DEBUG : two: Unchanged skipping 2025/07/05 07:54:04 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/07/05 07:54:09 INFO : one: Deleted 2025/07/05 07:54:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:54:14 DEBUG : one: md5 = d21506e25fe29f39080d4b8083018190 OK 2025/07/05 07:54:14 INFO : one: Copied (new) 2025/07/05 07:54:14 DEBUG : Waiting for deletions to finish 2025/07/05 07:54:35 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/07/05 07:54:40 INFO : three.txt: Deleted 2025/07/05 07:54:40 INFO : three.txt: Moved into backup dir 2025/07/05 07:54:51 DEBUG : dst/three.txt: md5 = 3c6167693168fda26ef25b3cf5f37043 OK 2025/07/05 07:54:56 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 07:54:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:54:57 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:54:57 DEBUG : two: Unchanged skipping 2025/07/05 07:55:12 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/07/05 07:55:17 INFO : one: Deleted 2025/07/05 07:55:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:55:22 DEBUG : one: md5 = 4c1f7619c7fa476dc162903c7ce6d40f OK 2025/07/05 07:55:22 INFO : one: Copied (new) 2025/07/05 07:55:22 DEBUG : Waiting for deletions to finish 2025/07/05 07:55:43 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/07/05 07:55:48 INFO : three.txt: Deleted 2025/07/05 07:55:48 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (193.85s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:56:25 DEBUG : dst/one: md5 = 68edce833f983eaa2b781b97b9f73fb7 OK 2025/07/05 07:56:25 DEBUG : dst/two: md5 = 11104a7e299067d7ccbf0099acb425ca OK 2025/07/05 07:56:30 DEBUG : dst/three.txt: md5 = 13ab6d01d98d5c138588714aa86c7e74 OK 2025/07/05 07:56:30 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/dst" 2025/07/05 07:56:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst.bin" 2025/07/05 07:56:31 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst.bin: Auto set use_segments_container to true 2025/07/05 07:56:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst" 2025/07/05 07:56:36 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst: Auto set use_segments_container to true 2025/07/05 07:56:42 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 07:56:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:56:42 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:56:42 DEBUG : two: Unchanged skipping 2025/07/05 07:57:02 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 07:57:07 INFO : one: Deleted 2025/07/05 07:57:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:57:12 DEBUG : one: md5 = 1c82e550c41a32d73ff889c482419d1a OK 2025/07/05 07:57:12 INFO : one: Copied (new) 2025/07/05 07:57:12 DEBUG : Waiting for deletions to finish 2025/07/05 07:57:28 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 07:57:33 INFO : three.txt: Deleted 2025/07/05 07:57:33 INFO : three.txt: Moved into backup dir 2025/07/05 07:57:39 DEBUG : dst/three.txt: md5 = 55808de9de3e2977bbe3ff0da36ccaec OK 2025/07/05 07:57:44 DEBUG : one.bak: Excluded (Path Filter) 2025/07/05 07:57:44 DEBUG : one.bak: Excluded 2025/07/05 07:57:44 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/07/05 07:57:44 DEBUG : three.txt.bak: Excluded 2025/07/05 07:57:44 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 07:57:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for checks to finish 2025/07/05 07:57:45 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:57:45 DEBUG : two: Unchanged skipping 2025/07/05 07:57:55 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 07:58:00 INFO : one: Deleted 2025/07/05 07:58:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe/dst': Waiting for transfers to finish 2025/07/05 07:58:05 DEBUG : one: md5 = e74552c2c034262249eea1a33ab61b0c OK 2025/07/05 07:58:05 INFO : one: Copied (new) 2025/07/05 07:58:05 DEBUG : Waiting for deletions to finish 2025/07/05 07:58:20 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 07:58:26 INFO : three.txt: Deleted 2025/07/05 07:58:26 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (147.34s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 07:58:52 DEBUG : dst/one: md5 = 9f063ce3963d9ede5abe285142873a9c OK 2025/07/05 07:58:52 DEBUG : dst/two: md5 = d5472687fe542112da6897b627ef2706 OK 2025/07/05 07:58:57 DEBUG : dst/three.txt: md5 = e8b9c8538ac4bfebad45f606e8bcd894 OK 2025/07/05 07:58:57 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/dst" 2025/07/05 07:58:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst.bin" 2025/07/05 07:58:58 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst.bin: Auto set use_segments_container to true 2025/07/05 07:59:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst" 2025/07/05 07:59:03 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst: Auto set use_segments_container to true 2025/07/05 07:59:08 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 07:59:24 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 07:59:29 INFO : one: Deleted 2025/07/05 07:59:34 DEBUG : one: md5 = b997cf57c653d48b5e2bb8ed3d7a38e5 OK 2025/07/05 07:59:34 INFO : one: Copied (new) 2025/07/05 07:59:34 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 07:59:34 DEBUG : two: Unchanged skipping 2025/07/05 07:59:34 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/07/05 07:59:50 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 07:59:55 INFO : three.txt: Deleted 2025/07/05 08:00:00 DEBUG : three.txt: md5 = cdd3b19d43005323d80573f20a10082e OK 2025/07/05 08:00:00 INFO : three.txt: Copied (new) 2025/07/05 08:00:16 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 08:00:26 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 08:00:31 INFO : one: Deleted 2025/07/05 08:00:36 DEBUG : one: md5 = f8bfc45e99da565de2dc8622d9d73345 OK 2025/07/05 08:00:36 INFO : one: Copied (new) 2025/07/05 08:00:36 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:00:36 DEBUG : two: Unchanged skipping 2025/07/05 08:00:36 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/07/05 08:00:47 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 08:00:52 INFO : three.txt: Deleted 2025/07/05 08:00:57 DEBUG : three.txt: md5 = 9ae90cbd04a923f6ac86f1ad3b49d0a2 OK 2025/07/05 08:00:57 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (161.80s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 08:01:33 DEBUG : dst/one: md5 = 5bdf6f51e83e0b227bb133ca83865960 OK 2025/07/05 08:01:34 DEBUG : dst/two: md5 = e998cd6661aa4cb112e498be24cfa0a3 OK 2025/07/05 08:01:39 DEBUG : dst/three.txt: md5 = 371fc54ebcbe7f824de7ae3070685086 OK 2025/07/05 08:01:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tizewol7rohe/dst" 2025/07/05 08:01:44 DEBUG : Config file has changed externally - reloading 2025/07/05 08:01:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst.bin" 2025/07/05 08:01:45 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst.bin: Auto set use_segments_container to true 2025/07/05 08:01:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tizewol7rohe/dst" 2025/07/05 08:01:50 DEBUG : Swift container crypt path rclone-test-tizewol7rohe/dst: Auto set use_segments_container to true 2025/07/05 08:02:00 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 08:02:16 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/07/05 08:02:21 INFO : one: Deleted 2025/07/05 08:02:26 DEBUG : one: md5 = 4f62ad635f4dc39a416eac2a1e41a4af OK 2025/07/05 08:02:26 INFO : one: Copied (new) 2025/07/05 08:02:26 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:02:26 DEBUG : two: Unchanged skipping 2025/07/05 08:02:27 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/07/05 08:02:52 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/07/05 08:02:57 INFO : three.txt: Deleted 2025/07/05 08:03:02 DEBUG : three.txt: md5 = 6dc455044338c103d604f2100d7dc1dd OK 2025/07/05 08:03:02 INFO : three.txt: Copied (new) 2025/07/05 08:03:13 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 08:03:29 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/07/05 08:03:34 INFO : one: Deleted 2025/07/05 08:03:39 DEBUG : one: md5 = f8ecdba35d7c1a2e63121395f3d181ca OK 2025/07/05 08:03:39 INFO : one: Copied (new) 2025/07/05 08:03:39 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:03:39 DEBUG : two: Unchanged skipping 2025/07/05 08:03:44 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/07/05 08:03:59 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/07/05 08:04:05 INFO : three.txt: Deleted 2025/07/05 08:04:10 DEBUG : three.txt: md5 = 44608daf71382446500890c4b59cca68 OK 2025/07/05 08:04:10 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (188.01s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 08:04:42 DEBUG : Testêé: md5 = ad5af311527fe168ad45bdbf8b46d867 OK 2025/07/05 08:04:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 08:04:42 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/07/05 08:04:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 08:04:47 DEBUG : Testêé: md5 = 55ac2708a808baf516a2cfaa7bef8834 OK 2025/07/05 08:04:47 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/07/05 08:04:47 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (16.32s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 08:04:53 DEBUG : existing: Need to transfer - File not found at Destination 2025/07/05 08:04:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 08:04:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 08:04:58 DEBUG : existing: md5 = b840bfcf174e48e70644c8f8841f46fd OK 2025/07/05 08:04:58 INFO : existing: Copied (new) 2025/07/05 08:04:58 DEBUG : Waiting for deletions to finish 2025/07/05 08:05:03 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/07/05 08:05:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 08:05:08 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/07/05 08:05:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 08:05:08 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': not deleting files as there were IO errors 2025/07/05 08:05:08 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': not deleting directories as there were IO errors --- PASS: TestSyncImmutable (31.13s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 08:05:24 DEBUG : EXISTING: md5 = 19cac96c98b3072d32e2aea5657fd336 OK 2025/07/05 08:05:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 08:05:24 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:05:24 DEBUG : existing: Unchanged skipping 2025/07/05 08:05:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 08:05:24 DEBUG : Waiting for deletions to finish 2025/07/05 08:05:24 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.16s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:2665: 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-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:2704: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:2704: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" sync_test.go:2704: This test only runs on local --- PASS: TestMaxTransfer (0.41s) --- SKIP: TestMaxTransfer/Hard (0.10s) --- SKIP: TestMaxTransfer/Soft (0.21s) --- SKIP: TestMaxTransfer/Cautious (0.10s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 08:05:31 DEBUG : both0: md5 = 3da4b2e03a40dee834eb588ee2ece58c OK 2025/07/05 08:05:31 DEBUG : only0: md5 = 4dc3aa587519b7196e895f2efde37569 OK 2025/07/05 08:05:31 DEBUG : both1: md5 = 7fe36f50e1ca616f9d1ad1f3889f9848 OK 2025/07/05 08:05:32 DEBUG : only1: md5 = 9dd90d0b50f84164e05b3ed10df62bb1 OK 2025/07/05 08:05:37 DEBUG : both2: md5 = abfdeabfeec2153db251e39d2cde61a1 OK 2025/07/05 08:05:38 DEBUG : only2: md5 = 75db1a45d3a9bb112dd4a9f0aec908ec OK 2025/07/05 08:05:39 DEBUG : both3: md5 = 3051cee129d0d5c68a24fc0f975e8571 OK 2025/07/05 08:05:39 DEBUG : only3: md5 = 747caca4495e511edee361e3ab160edb OK 2025/07/05 08:05:40 DEBUG : both4: md5 = 3f25e3462c36093efa7d2df2d7aaeee1 OK 2025/07/05 08:05:47 DEBUG : only4: md5 = 10e9b90f8b11ddd076427312812a798d OK 2025/07/05 08:05:52 DEBUG : both5: md5 = 9e641ca73f4b731e5f3de7e079f496af OK 2025/07/05 08:06:00 DEBUG : only5: md5 = 64a95716bb7621a22b8f3640f0805fca OK 2025/07/05 08:06:00 DEBUG : both6: md5 = 70f30203f114d62297b5f414377f16e1 OK 2025/07/05 08:06:06 DEBUG : only6: md5 = 404059c8281a5a051bfbc716047b910e OK 2025/07/05 08:06:11 DEBUG : both7: md5 = 020a7438f9d4edfda115763e1d9e5b02 OK 2025/07/05 08:06:17 DEBUG : only7: md5 = bc5c582f93f534773bcf8cf277a4d604 OK 2025/07/05 08:06:23 DEBUG : both8: md5 = e69014e128657b28ccbcecf87cbd9c35 OK 2025/07/05 08:06:23 DEBUG : only8: md5 = b4ca520bb49f2588e1dc37575def02f7 OK 2025/07/05 08:06:24 DEBUG : both9: md5 = e8e0416c33f17fcdef885a4ded84f28a OK 2025/07/05 08:06:29 DEBUG : only9: md5 = e22d1cb28956213041b26ba854a8bf94 OK 2025/07/05 08:06:34 DEBUG : both10: md5 = 7055035cfbdaa7670fd17e1f6e413933 OK 2025/07/05 08:06:40 DEBUG : only10: md5 = 41bbc3695710ecf2c39a1f3d6716db96 OK 2025/07/05 08:06:45 DEBUG : both11: md5 = b06e15cf7031c358be4d17e5179f74fd OK 2025/07/05 08:06:45 DEBUG : only11: md5 = 728c2ba5c2c47d07763ac6357c120b88 OK 2025/07/05 08:06:46 DEBUG : both12: md5 = d582b784fc31c5615647ebafe8435ec5 OK 2025/07/05 08:06:46 DEBUG : only12: md5 = 963325346e3296dbf2224f8829248d0d OK 2025/07/05 08:06:51 DEBUG : both13: md5 = 53d0d546622d3fea6f4b1c2de4a5c5ca OK 2025/07/05 08:06:56 DEBUG : only13: md5 = caa8973a744ec593d2c5c9afde1f9d9e OK 2025/07/05 08:07:02 DEBUG : both14: md5 = 134feccc535bf57b789aad30ddaef1e5 OK 2025/07/05 08:07:07 DEBUG : only14: md5 = dcea419d45109c740a0e085d3c712970 OK 2025/07/05 08:07:12 DEBUG : both15: md5 = ab5506e0c61553fa75db4b97f2941c9e OK 2025/07/05 08:07:18 DEBUG : only15: md5 = 85649ba228ec2e26c3c7e26f7e0268b4 OK 2025/07/05 08:07:23 DEBUG : both16: md5 = 2020f09a334ca01001b9ef3a6751c992 OK 2025/07/05 08:07:28 DEBUG : only16: md5 = 0361a859e8db720278835a30738db8f7 OK 2025/07/05 08:07:34 DEBUG : both17: md5 = 261d02f784546b21f94d758609fe93ad OK 2025/07/05 08:07:34 DEBUG : only17: md5 = 5b8bb0469a7e0f06c6a7379c95a7d21a OK 2025/07/05 08:07:35 DEBUG : both18: md5 = 54b9e7f4d9a6fa7a87080436ac4e49b5 OK 2025/07/05 08:07:40 DEBUG : only18: md5 = 39a1d2ecb89bc56e3d2d730be79ceb00 OK 2025/07/05 08:07:46 DEBUG : both19: md5 = 63cb249cb81e7cb61e3664e0a659d0cb OK 2025/07/05 08:07:46 DEBUG : only19: md5 = f8264b8b623c603259c68411a7c44fdb OK 2025/07/05 08:08:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 08:08:18 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:18 DEBUG : both0: Unchanged skipping 2025/07/05 08:08:18 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:18 DEBUG : both10: Unchanged skipping 2025/07/05 08:08:18 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:18 DEBUG : both11: Unchanged skipping 2025/07/05 08:08:18 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:18 DEBUG : both12: Unchanged skipping 2025/07/05 08:08:18 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:18 DEBUG : both14: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both13: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both15: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both16: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both18: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both17: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both1: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both2: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both3: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both4: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both5: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both6: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both7: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both8: Unchanged skipping 2025/07/05 08:08:23 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:23 DEBUG : both9: Unchanged skipping 2025/07/05 08:08:28 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:08:28 DEBUG : both19: Unchanged skipping 2025/07/05 08:08:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 08:08:28 DEBUG : Waiting for deletions to finish 2025/07/05 08:08:28 INFO : only3: Deleted 2025/07/05 08:08:29 INFO : only1: Deleted 2025/07/05 08:08:33 INFO : only18: Deleted 2025/07/05 08:08:34 INFO : only9: Deleted 2025/07/05 08:08:34 INFO : only8: Deleted 2025/07/05 08:08:34 INFO : only11: Deleted 2025/07/05 08:08:34 INFO : only12: Deleted 2025/07/05 08:08:34 INFO : only4: Deleted 2025/07/05 08:08:34 INFO : only2: Deleted 2025/07/05 08:08:38 INFO : only13: Deleted 2025/07/05 08:08:38 INFO : only17: Deleted 2025/07/05 08:08:39 INFO : only5: Deleted 2025/07/05 08:08:39 INFO : only19: Deleted 2025/07/05 08:08:39 INFO : only10: Deleted 2025/07/05 08:08:39 INFO : only0: Deleted 2025/07/05 08:08:44 INFO : only7: Deleted 2025/07/05 08:08:44 INFO : only15: Deleted 2025/07/05 08:08:49 INFO : only6: Deleted 2025/07/05 08:08:49 INFO : only14: Deleted 2025/07/05 08:08:54 INFO : only16: Deleted 2025/07/05 08:08:54 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (313.12s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe'", Local "Local file system at /tmp/rclone2770026733", Modify Window "1ns" 2025/07/05 08:10:44 DEBUG : both0: md5 = a5fa0f040df7158dc318d01964e89ee6 OK 2025/07/05 08:10:44 DEBUG : only0: md5 = 227a9bd26de1d66ab3058f1a365e51a2 OK 2025/07/05 08:10:44 DEBUG : both1: md5 = b31bd1437d6a01b57035c92ef31a41e0 OK 2025/07/05 08:10:45 DEBUG : only1: md5 = 674bde211220b629ddbb4e63ec280a3b OK 2025/07/05 08:10:50 DEBUG : both2: md5 = 328a0872b7992f7df426cbd6b71e92f6 OK 2025/07/05 08:10:50 DEBUG : only2: md5 = 65e3a0f6d3b68b6a98e3cc7a1a992bb9 OK 2025/07/05 08:10:50 DEBUG : both3: md5 = 6bf8b731b4348701fefb62911b18dc57 OK 2025/07/05 08:10:50 DEBUG : only3: md5 = d6785b46b7a4dfb1794a237d430d656e OK 2025/07/05 08:10:51 DEBUG : both4: md5 = 6417ec5e69df539f023434287a5cc142 OK 2025/07/05 08:10:56 DEBUG : only4: md5 = e01532a51238714e91429a72bbbd43bc OK 2025/07/05 08:11:01 DEBUG : both5: md5 = 4845e3b8ffddb2a14ed42e44d4fe1bc7 OK 2025/07/05 08:11:06 DEBUG : only5: md5 = e096556b4625d6082c29f8174c13dfa9 OK 2025/07/05 08:11:07 DEBUG : both6: md5 = 9bb442438ad1881f75a6c38b46e34754 OK 2025/07/05 08:11:12 DEBUG : only6: md5 = 35f128da0a953d9e0745ae3c638fc326 OK 2025/07/05 08:11:17 DEBUG : both7: md5 = d1332ad7b145892509274d3d69feb959 OK 2025/07/05 08:11:22 DEBUG : only7: md5 = 403730c8fc408066da93c35d9037825d OK 2025/07/05 08:11:27 DEBUG : both8: md5 = 8e90adc5b37585893e917bd684f31f41 OK 2025/07/05 08:11:28 DEBUG : only8: md5 = f7e78ebd7fe0d05d7e56563771119780 OK 2025/07/05 08:11:28 DEBUG : both9: md5 = 268448325a249956699ebdba2a03ca47 OK 2025/07/05 08:11:33 DEBUG : only9: md5 = 495286a4e26f31784bbc851e3dea3a04 OK 2025/07/05 08:11:38 DEBUG : both10: md5 = f1fe9056c3ad92b283a25173c27e3010 OK 2025/07/05 08:11:43 DEBUG : only10: md5 = d3c4287f3a25c5107be9c4d56e7de20c OK 2025/07/05 08:11:49 DEBUG : both11: md5 = 5d8d5f04a6b954368fadf29690dc9c84 OK 2025/07/05 08:11:49 DEBUG : only11: md5 = 4e1e20d17c643cb76e82fac6414a4d93 OK 2025/07/05 08:11:49 DEBUG : both12: md5 = 8ff932c18067a32f120211ef94bded53 OK 2025/07/05 08:11:49 DEBUG : only12: md5 = 3f9bb95078a733fc4433ee8de6ce83fa OK 2025/07/05 08:11:54 DEBUG : both13: md5 = 3f0e68e7bc8b7ece9fbf9f1482445982 OK 2025/07/05 08:11:59 DEBUG : only13: md5 = a4f1bae087bb2022df389dec709dd477 OK 2025/07/05 08:12:04 DEBUG : both14: md5 = a5e1cbe69497ff4adbcedadf80205e47 OK 2025/07/05 08:12:10 DEBUG : only14: md5 = ceee39444a6989d2529cf51cdc6818e0 OK 2025/07/05 08:12:15 DEBUG : both15: md5 = de511c8cca98e7b369ab74b83ab406df OK 2025/07/05 08:12:20 DEBUG : only15: md5 = 08db82fb50c9b94981e74cc606430a07 OK 2025/07/05 08:12:25 DEBUG : both16: md5 = 4810bfd42cb58e521a165e53e344d5b2 OK 2025/07/05 08:12:30 DEBUG : only16: md5 = b00fb616d40760c972839a1f433dbdb5 OK 2025/07/05 08:12:36 DEBUG : both17: md5 = cb5898af18884b750aa789bead64d2e1 OK 2025/07/05 08:12:36 DEBUG : only17: md5 = 5b313641ab46c99efcb7ab0400a129e6 OK 2025/07/05 08:12:36 DEBUG : both18: md5 = 83c04026a4360b893aa955b04b082281 OK 2025/07/05 08:12:41 DEBUG : only18: md5 = 5ed779df063e0c906cb54650413c72c0 OK 2025/07/05 08:12:48 DEBUG : both19: md5 = 8cd91a8a409dd3c9e283ce7e068a18f1 OK 2025/07/05 08:12:48 DEBUG : only19: md5 = 8af7821824591352006e7e1085d8dc75 OK 2025/07/05 08:13:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for checks to finish 2025/07/05 08:13:40 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both10: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both0: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both11: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both12: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both13: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both16: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both17: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both18: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both19: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both1: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both2: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both3: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both4: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both5: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both6: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both7: Unchanged skipping 2025/07/05 08:13:40 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:40 DEBUG : both9: Unchanged skipping 2025/07/05 08:13:40 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:40 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/07/05 08:13:41 DEBUG : only0: md5 = da7a9e72ac9873af5fc55a7e247fe5f7 OK 2025/07/05 08:13:41 INFO : only0: Copied (replaced existing) 2025/07/05 08:13:41 DEBUG : only11: md5 = faed1a8eab74739750a2e834bc301e9a OK 2025/07/05 08:13:41 INFO : only11: Copied (replaced existing) 2025/07/05 08:13:41 DEBUG : only12: md5 = cf21e1ba7734ef4f40cc2551cc09b254 OK 2025/07/05 08:13:41 INFO : only12: Copied (replaced existing) 2025/07/05 08:13:45 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:45 DEBUG : both14: Unchanged skipping 2025/07/05 08:13:45 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:45 DEBUG : both15: Unchanged skipping 2025/07/05 08:13:45 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 08:13:45 DEBUG : both8: Unchanged skipping 2025/07/05 08:13:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tizewol7rohe': Waiting for transfers to finish 2025/07/05 08:13:46 DEBUG : only10: md5 = c3e96e2719129955068a962bb76b6a1f OK 2025/07/05 08:13:46 INFO : only10: Copied (replaced existing) 2025/07/05 08:13:46 DEBUG : only14: md5 = 988b8af98f05ea4ee01742165c622c9a OK 2025/07/05 08:13:46 INFO : only14: Copied (replaced existing) 2025/07/05 08:13:46 DEBUG : only15: md5 = b033853b2c5b371ce0b4e09a60f40ee6 OK 2025/07/05 08:13:46 INFO : only15: Copied (replaced existing) 2025/07/05 08:13:46 DEBUG : only17: md5 = f4aafa0a4660400d4929869073ddabaa OK 2025/07/05 08:13:46 INFO : only17: Copied (replaced existing) 2025/07/05 08:13:46 DEBUG : only19: md5 = 13f0b1ce274b869195e8067fcf9008e9 OK 2025/07/05 08:13:46 INFO : only19: Copied (replaced existing) 2025/07/05 08:13:47 DEBUG : only1: md5 = f0c40fbada9bfd5740646f721626ec5f OK 2025/07/05 08:13:47 INFO : only1: Copied (replaced existing) 2025/07/05 08:13:47 DEBUG : only2: md5 = a922a4e7ea0f969258327dd16b5a3ef4 OK 2025/07/05 08:13:47 INFO : only2: Copied (replaced existing) 2025/07/05 08:13:47 DEBUG : only3: md5 = 0f62e5985319d84b515fd54b67776dfc OK 2025/07/05 08:13:47 INFO : only3: Copied (replaced existing) 2025/07/05 08:13:51 DEBUG : only13: md5 = 4570abed71519ff7ef3a476b13a008ca OK 2025/07/05 08:13:51 INFO : only13: Copied (replaced existing) 2025/07/05 08:13:52 DEBUG : only4: md5 = 9192e4910410040fe76430002510a487 OK 2025/07/05 08:13:52 INFO : only4: Copied (replaced existing) 2025/07/05 08:13:56 DEBUG : only5: md5 = 33e6beafd7ca8f107514aa3af3e9c57e OK 2025/07/05 08:13:56 INFO : only5: Copied (replaced existing) 2025/07/05 08:13:56 DEBUG : only16: md5 = 9a9b7349ddef584ef2f334b876369522 OK 2025/07/05 08:13:56 INFO : only16: Copied (replaced existing) 2025/07/05 08:13:56 DEBUG : only18: md5 = 0d950df05764c9b50fa2efcc664f224a OK 2025/07/05 08:13:56 INFO : only18: Copied (replaced existing) 2025/07/05 08:13:56 DEBUG : only8: md5 = 50f2f09a377b7763f0d07734a0f2877c OK 2025/07/05 08:13:56 INFO : only8: Copied (replaced existing) 2025/07/05 08:13:58 DEBUG : only6: md5 = 26a0d8759dd6e68187dc3c05dbfdc5f4 OK 2025/07/05 08:13:58 INFO : only6: Copied (replaced existing) 2025/07/05 08:14:01 DEBUG : only7: md5 = 7c520132d864f88b22f1214b3324e670 OK 2025/07/05 08:14:01 INFO : only7: Copied (replaced existing) 2025/07/05 08:14:06 DEBUG : only9: md5 = 496263aaa8c3c8ae071f81c877e0fb7e OK 2025/07/05 08:14:06 INFO : only9: Copied (replaced existing) 2025/07/05 08:14:06 DEBUG : Waiting for deletions to finish panic: test timed out after 1h0m0s running tests: TestSyncConcurrentTruncate (5m4s) goroutine 12898 [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, 6 minutes]: testing.(*T).Run(0xc001941340, {0x26bd751?, 0xc00006bad8?}, 0x27bf900) /usr/local/go/src/testing/testing.go:1859 +0x431 testing.runTests.func1(0xc001941340) /usr/local/go/src/testing/testing.go:2279 +0x37 testing.tRunner(0xc001941340, 0xc00006bc18) /usr/local/go/src/testing/testing.go:1792 +0xf4 testing.runTests(0xc001a2a1b0, {0x3e79440, 0x6c, 0x6c}, {0xedffac81f?, 0x3e8f400?, 0x3e8f400?}) /usr/local/go/src/testing/testing.go:2277 +0x4b4 testing.(*M).Run(0xc000498c80) /usr/local/go/src/testing/testing.go:2142 +0x64a github.com/rclone/rclone/fstest.TestMain(0xc000498c80) /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:261 +0xa9 goroutine 21 [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 22 [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 12274 [select]: github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc001a16000, 0xc0003b88c0, 0xc00042c280) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115 github.com/ncw/swift/v2.(*Connection).Call(0xc001a16000, {0x2af2988, 0x3eb29c0}, {0xc0019bd040, 0x4f}, {{0xc001a98150, 0x5}, {0xc001a98156, 0x23}, {0x2678bc8, ...}, ...}) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6 github.com/ncw/swift/v2.(*Connection).storage(0xc001a16000, {0x2af2988, 0x3eb29c0}, {{0xc001a98150, 0x5}, {0xc001a98156, 0x23}, {0x2678bc8, 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(0xc0003ed290?, {0x2af2988?, 0x3eb29c0?}, {0xc001a98150?, 0xa?}, {0xc001a98156, 0x23}) /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, 0xc00006b420) /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, 0xc000100808?) /home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32 github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc001b00fc0, 0xc000b2e9c0, 0xa) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:199 +0x7c github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc001b00fc0, 0xc000b2e9c0) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:218 +0x93 github.com/rclone/rclone/backend/swift.(*Object).readMetaData(0xc001cf4b40, {0x2af2988, 0x3eb29c0}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1333 +0x165 github.com/rclone/rclone/backend/swift.(*Object).hasHeader(0xc001cf4b40, {0x2af2988?, 0x3eb29c0?}, {0x26ad55e, 0x15}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1246 +0x30 github.com/rclone/rclone/backend/swift.(*Object).isLargeObject(0xc001cf4b40, {0x2af2988, 0x3eb29c0}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1277 +0x48 github.com/rclone/rclone/backend/swift.(*Object).Remove(0xc001cf4b40, {0x2af2988, 0x3eb29c0}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1597 +0x96 github.com/rclone/rclone/fstest.newRunIndividual.func1.1.1() /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x24 github.com/rclone/rclone/fstest.retry(0xc001b6a000, {0xc001a10f00, 0x16}, 0xc00006b8c8) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:121 +0xde github.com/rclone/rclone/fstest.newRunIndividual.func1.1({0xc000630008?, 0xc000630008?, 0x1e018f4?}) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x29a github.com/rclone/rclone/fs/walk.listR.func1({0xc000630008, 0x28, 0x47}) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:331 +0x1ca github.com/rclone/rclone/backend/crypt.(*Fs).ListR.func1({0xc000630008?, 0xc00207e460?, 0x5?}) /home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:481 +0x5b github.com/rclone/rclone/fs/list.(*Helper).send(...) /home/rclone/go/src/github.com/rclone/rclone/fs/list/helpers.go:29 github.com/rclone/rclone/fs/list.(*Helper).Flush(0xc00006bb30) /home/rclone/go/src/github.com/rclone/rclone/fs/list/helpers.go:47 +0x35 github.com/rclone/rclone/backend/swift.(*Fs).ListR(0xc000103c00, {0x2af2988, 0x3eb29c0}, {0x0?, 0x2414d20?}, 0xc00015f4a0) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:881 +0x185 github.com/rclone/rclone/backend/crypt.(*Fs).ListR(0xc001a1a270, {0x2af2988, 0x3eb29c0}, {0x0, 0x0}, 0xc00063d8b0) /home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:476 +0x118 github.com/rclone/rclone/fs/walk.listR({0x2af2988, 0x3eb29c0}, {0x2b07040, 0xc001a1a270}, {0x0, 0x0}, 0x1, 0x3, 0xc00015f380, 0xc0019add58, ...) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:299 +0x292 github.com/rclone/rclone/fs/walk.ListR({0x2af2988, 0x3eb29c0}, {0x2b07040, 0xc001a1a270}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc00015f380) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:163 +0x1d5 github.com/rclone/rclone/fstest.newRunIndividual.func1() /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:150 +0x107 github.com/rclone/rclone/fstest.(*Run).Finalise(0xc0004f6380) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 +0x1c testing.(*common).Cleanup.func1() /usr/local/go/src/testing/testing.go:1211 +0x106 testing.(*common).runCleanup(0xc001b6a000, 0x8?) /usr/local/go/src/testing/testing.go:1445 +0xea testing.tRunner.func2() /usr/local/go/src/testing/testing.go:1786 +0x25 testing.tRunner(0xc001b6a000, 0x27bf900) /usr/local/go/src/testing/testing.go:1798 +0x11e created by testing.(*T).Run in goroutine 1 /usr/local/go/src/testing/testing.go:1851 +0x413 goroutine 2135 [chan receive, 53 minutes]: github.com/rclone/rclone/lib/atexit.Register.func1.1() /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:45 +0x29 created by github.com/rclone/rclone/lib/atexit.Register.func1 in goroutine 2105 /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68 goroutine 12887 [select]: net/http.(*persistConn).roundTrip(0xc0006a26c0, 0xc0006a5860) /usr/local/go/src/net/http/transport.go:2826 +0x785 net/http.(*Transport).roundTrip(0xc00008a340, 0xc00042c280) /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(0xc0004f6150, 0xc00042c280) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345 net/http.send(0xc00042c280, {0x2acbec0, 0xc0004f6150}, {0x1?, 0x0?, 0x0?}) /usr/local/go/src/net/http/client.go:259 +0x5e2 net/http.(*Client).send(0xc0019d1a70, 0xc00042c280, {0x0?, 0x0?, 0x0?}) /usr/local/go/src/net/http/client.go:180 +0x91 net/http.(*Client).do(0xc0019d1a70, 0xc00042c280) /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 12274 /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8 goroutine 12607 [select]: net/http.(*persistConn).writeLoop(0xc0006a26c0) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 12578 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 12606 [IO wait]: internal/poll.runtime_pollWait(0x77b771a19060, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0004bec00?, 0xc0006c9500?, 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(0xc0004bec00, {0xc0006c9500, 0x3500, 0x3500}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0004bec00, {0xc0006c9500?, 0x34f3?, 0xc001a7fbe0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc000446100, {0xc0006c9500?, 0xc0003f08d0?, 0xd?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000477de8, {0xc0006c9500?, 0x77b728779b78?, 0x77b771e35a78?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc001ff5e18, {0xc0006c9500?, 0x34f3?, 0xc000b279d0?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0003f09b8, {0x2acd440, 0xc001ff5e18}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc0003f0708, {0x77b7285c0a98, 0xc000477de8}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc0003f0708, 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(0xc0003f0708, {0xc0009cc000, 0x1000, 0xc0000cd410?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc0006a26c0, {0xc0009cc000?, 0x7f4fc5?, 0x2aca340?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc001f01320) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc001f01320, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc0006a26c0) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 12578 /usr/local/go/src/net/http/transport.go:1944 +0x174f "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished ERROR in 1h0m11.513493744s (try 4/5): exit status 2: Failed []