"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2025/01/28 01:17:01 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo" 2025/01/28 01:17:01 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/28 01:17:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo.bin" 2025/01/28 01:17:01 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo.bin: Auto set use_segments_container to true 2025/01/28 01:17:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo" 2025/01/28 01:17:02 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo: Auto set use_segments_container to true 2025/01/28 01:17:03 DEBUG : Creating backend with remote "/tmp/rclone1663140297" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.02s) === 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-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:03 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/01/28 01:17:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.59s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:03 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/01/28 01:17:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:04 DEBUG : sub dir/hello world: md5 = ddd9388b0416bde02da18f15fc112bce OK 2025/01/28 01:17:04 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (1.47s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.10s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.18s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:05 DEBUG : Creating backend with remote "/non-existing" 2025/01/28 01:17:05 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/01/28 01:17:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.24s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:05 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:06 DEBUG : sub dir/hello world: md5 = 6ca736b50008bd49ffe795165e59bc41 OK 2025/01/28 01:17:06 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyNoTraverse (1.24s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:07 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Running all checks before starting transfers 2025/01/28 01:17:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:07 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Checks finished, now starting transfers 2025/01/28 01:17:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:07 DEBUG : sub dir/hello world: md5 = d776fb08478f0ba5ab495daf8ef7dc6d OK 2025/01/28 01:17:07 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyCheckFirst (1.23s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:08 ERROR : Ignoring --no-traverse with sync 2025/01/28 01:17:08 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:08 DEBUG : sub dir/hello world: md5 = 3c88f36387493f8602eb2927283596f6 OK 2025/01/28 01:17:08 INFO : sub dir/hello world: Copied (new) 2025/01/28 01:17:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncNoTraverse (1.47s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:09 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/01/28 01:17:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:10 DEBUG : hello world2: md5 = f8e04675b92c620379cd2a65c1760d1e OK 2025/01/28 01:17:10 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyWithDepth (1.39s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:11 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:17:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:11 DEBUG : potato2: md5 = c54b18b990e2adc61ec70439b5f02bfe OK 2025/01/28 01:17:11 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (1.55s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:12 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:17:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:13 DEBUG : potato2: md5 = b50843065dc0887b876b1bb17f38d15e OK 2025/01/28 01:17:13 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (1.21s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:13 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/01/28 01:17:13 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/01/28 01:17:13 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/01/28 01:17:13 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/01/28 01:17:13 INFO : sub dir: Making directory 2025/01/28 01:17:13 INFO : sub dir2: Making directory 2025/01/28 01:17:13 INFO : sub dir2/sub sub dir2: Making directory 2025/01/28 01:17:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:14 DEBUG : sub dir/hello world: md5 = b85bcb3bf2cb94542da6dc291cd9cbf4 OK 2025/01/28 01:17:14 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2025/01/28 01:17:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (1.22s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:15 INFO : sub dir2: Making directory 2025/01/28 01:17:15 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/01/28 01:17:15 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/01/28 01:17:15 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:15 DEBUG : sub dir/hello world: md5 = cfdc2f7d9faacf4723015cc9d5c14628 OK 2025/01/28 01:17:15 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (1.14s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:16 DEBUG : sub dir2: Making directory with metadata 2025/01/28 01:17:16 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/01/28 01:17:16 INFO : sub dir: Making directory 2025/01/28 01:17:16 INFO : sub dir2: Making directory 2025/01/28 01:17:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:16 DEBUG : sub dir/hello world: md5 = b287978bccfa75565771133f1b41c30a OK 2025/01/28 01:17:16 INFO : sub dir/hello world: Copied (new) 2025/01/28 01:17:16 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/01/28 01:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/01/28 01:17:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.35s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.25s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:17 INFO : sub dir2: Making directory 2025/01/28 01:17:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:18 DEBUG : sub dir/hello world: md5 = b902be90627db3a3f7652118ae7759e5 OK 2025/01/28 01:17:18 INFO : sub dir/hello world: Copied (new) 2025/01/28 01:17:18 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (0.79s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:18 DEBUG : sub dir2: Making directory with metadata 2025/01/28 01:17:18 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/01/28 01:17:18 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/01/28 01:17:18 INFO : sub dir: Making directory 2025/01/28 01:17:18 INFO : sub dir2: Making directory 2025/01/28 01:17:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:19 DEBUG : sub dir/hello world: md5 = 54e2346353a767489a6dc6306e46961e OK 2025/01/28 01:17:19 INFO : sub dir/hello world: Copied (new) 2025/01/28 01:17:19 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/01/28 01:17:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.14s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.31s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:20 INFO : sub dir2: Making directory 2025/01/28 01:17:20 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:20 DEBUG : sub dir/hello world: md5 = 9610d03bc22dbee47f54e6af3e7bc1d8 OK 2025/01/28 01:17:20 INFO : sub dir/hello world: Copied (new) 2025/01/28 01:17:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (0.88s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:21 DEBUG : sub dir/hello world: md5 = ddbe3303939d13b5c17e36c70d7d1b0e OK 2025/01/28 01:17:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zitomih6wovo" 2025/01/28 01:17:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zitomih6wovo.bin" 2025/01/28 01:17:22 DEBUG : Swift container crypt path rclone-test-zitomih6wovo.bin: Auto set use_segments_container to true 2025/01/28 01:17:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zitomih6wovo" 2025/01/28 01:17:22 DEBUG : Swift container crypt path rclone-test-zitomih6wovo: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo' -> Encrypted drive 'TestCryptSwift:rclone-test-zitomih6wovo' 2025/01/28 01:17:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zitomih6wovo': Waiting for checks to finish 2025/01/28 01:17:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zitomih6wovo': Waiting for transfers to finish 2025/01/28 01:17:24 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zitomih6wovo': Purge remote 2025/01/28 01:17:24 DEBUG : Waiting for deletions to finish 2025/01/28 01:17:24 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (4.23s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:25 DEBUG : sub dir/hello world: md5 = 611fd00f12c1a4db11aadf4c137f17b4 OK 2025/01/28 01:17:26 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/01/28 01:17:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:26 DEBUG : sub dir/hello world: md5 = 5b641b42df4cdbb63e332bbb2c842bd3 OK 2025/01/28 01:17:26 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyOverSelf (1.96s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:27 DEBUG : sub dir/hello world: md5 = 70a31c2809ead16ee47171aacd8b7a01 OK 2025/01/28 01:17:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zedaluy3noha" 2025/01/28 01:17:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zedaluy3noha.bin" 2025/01/28 01:17:28 DEBUG : Swift container crypt path rclone-test-zedaluy3noha.bin: Auto set use_segments_container to true 2025/01/28 01:17:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zedaluy3noha" 2025/01/28 01:17:29 DEBUG : Swift container crypt path rclone-test-zedaluy3noha: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo' -> Encrypted drive 'TestCryptSwift:rclone-test-zedaluy3noha' 2025/01/28 01:17:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zedaluy3noha': Waiting for checks to finish 2025/01/28 01:17:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zedaluy3noha': Waiting for transfers to finish 2025/01/28 01:17:31 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:31 DEBUG : sub dir/hello world: md5 = 918ed0f8af81f30683175dd9d4e4decd OK 2025/01/28 01:17:32 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/01/28 01:17:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zedaluy3noha': Waiting for checks to finish 2025/01/28 01:17:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zedaluy3noha': Waiting for transfers to finish 2025/01/28 01:17:32 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zedaluy3noha': Purge remote 2025/01/28 01:17:32 DEBUG : Waiting for deletions to finish 2025/01/28 01:17:33 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (6.82s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:34 DEBUG : sub dir/hello world: md5 = abb854d8a85296077577989ebde31bd3 OK 2025/01/28 01:17:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:34 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/01/28 01:17:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:34 DEBUG : sub dir/hello world: md5 = f294b0f54d030d915d536fa6433be334 OK 2025/01/28 01:17:34 INFO : sub dir/hello world: Copied (replaced existing) 2025/01/28 01:17:34 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestMoveOverSelf (1.60s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:35 DEBUG : sub dir/hello world: md5 = 57d5e5f138ed23b952f81199aa788546 OK 2025/01/28 01:17:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xovetib9xara" 2025/01/28 01:17:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xovetib9xara.bin" 2025/01/28 01:17:36 DEBUG : Swift container crypt path rclone-test-xovetib9xara.bin: Auto set use_segments_container to true 2025/01/28 01:17:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xovetib9xara" 2025/01/28 01:17:37 DEBUG : Swift container crypt path rclone-test-xovetib9xara: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo' -> Encrypted drive 'TestCryptSwift:rclone-test-xovetib9xara' 2025/01/28 01:17:38 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovetib9xara': Waiting for checks to finish 2025/01/28 01:17:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovetib9xara': Waiting for transfers to finish 2025/01/28 01:17:39 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:39 DEBUG : sub dir/hello world: md5 = fda1fd783258361217ec93e86da6299d OK 2025/01/28 01:17:39 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/01/28 01:17:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovetib9xara': Waiting for checks to finish 2025/01/28 01:17:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovetib9xara': Waiting for transfers to finish 2025/01/28 01:17:40 INFO : sub dir/hello world: Copied (server-side copy) 2025/01/28 01:17:40 INFO : sub dir/hello world: Deleted 2025/01/28 01:17:40 DEBUG : sub dir/hello world: md5 = 7aba451a8fe0b3be57f072fcd45bda27 OK 2025/01/28 01:17:40 DEBUG : testing file moves 2025/01/28 01:17:41 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/01/28 01:17:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovetib9xara': Waiting for checks to finish 2025/01/28 01:17:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovetib9xara': Waiting for transfers to finish 2025/01/28 01:17:41 INFO : sub dir/hello world: Copied (server-side copy) 2025/01/28 01:17:41 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovetib9xara': Purge remote 2025/01/28 01:17:41 DEBUG : Waiting for deletions to finish 2025/01/28 01:17:42 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (6.96s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:42 DEBUG : sub dir/hello world: md5 = 1f53f75ba02f9a4cb2eece28a655ce36 OK 2025/01/28 01:17:42 ERROR : : error listing: directory not found 2025/01/28 01:17:42 INFO : Local file system at /tmp/rclone1663140297: Making directory 2025/01/28 01:17:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyAfterDelete (1.31s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:44 DEBUG : sub dir/hello world: md5 = a15a226fc810a842474c7f53ed438f9f OK 2025/01/28 01:17:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:17:44 DEBUG : Local file system at /tmp/rclone1663140297: Waiting for checks to finish 2025/01/28 01:17:44 DEBUG : Local file system at /tmp/rclone1663140297: Waiting for transfers to finish 2025/01/28 01:17:44 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/01/28 01:17:44 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyRedownload (1.12s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:45 DEBUG : check sum: Need to transfer - File not found at Destination 2025/01/28 01:17:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:45 DEBUG : check sum: md5 = 641a7ab4ef5aa563ae34f4bcd8726d86 OK 2025/01/28 01:17:45 INFO : check sum: Copied (new) 2025/01/28 01:17:45 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:45 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/01/28 01:17:45 DEBUG : check sum: Size of src and dst objects identical 2025/01/28 01:17:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:45 DEBUG : check sum: Unchanged skipping 2025/01/28 01:17:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:45 DEBUG : Waiting for deletions to finish 2025/01/28 01:17:45 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (1.66s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:46 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/01/28 01:17:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:47 DEBUG : sizeonly: md5 = 7eb455d3c3291ec75ceab068f74d844b OK 2025/01/28 01:17:47 INFO : sizeonly: Copied (new) 2025/01/28 01:17:47 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:48 DEBUG : sizeonly: Sizes identical 2025/01/28 01:17:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:48 DEBUG : sizeonly: Unchanged skipping 2025/01/28 01:17:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:48 DEBUG : Waiting for deletions to finish 2025/01/28 01:17:48 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncSizeOnly (2.50s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:49 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/01/28 01:17:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:49 DEBUG : ignore-size: md5 = b1b2058df9c058d22fb08b15d01d4c8a OK 2025/01/28 01:17:49 INFO : ignore-size: Copied (new) 2025/01/28 01:17:49 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:50 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:17:50 DEBUG : ignore-size: Unchanged skipping 2025/01/28 01:17:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:50 DEBUG : Waiting for deletions to finish 2025/01/28 01:17:50 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (1.70s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:51 DEBUG : existing: md5 = 057a6b319cb991a4da540f8fcff8f397 OK 2025/01/28 01:17:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:51 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:17:51 DEBUG : existing: Unchanged skipping 2025/01/28 01:17:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:51 DEBUG : Waiting for deletions to finish 2025/01/28 01:17:51 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:51 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/01/28 01:17:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:51 DEBUG : existing: md5 = 0a89727872250c5d1c2cdba69dab1e57 OK 2025/01/28 01:17:51 INFO : existing: Copied (replaced existing) 2025/01/28 01:17:51 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (1.96s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:52 DEBUG : existing: Need to transfer - File not found at Destination 2025/01/28 01:17:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:53 DEBUG : existing: md5 = 5f67cd9d490b970ad63fc518f0a7a2d8 OK 2025/01/28 01:17:53 INFO : existing: Copied (new) 2025/01/28 01:17:53 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:53 DEBUG : existing: Destination exists, skipping 2025/01/28 01:17:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:53 DEBUG : Waiting for deletions to finish 2025/01/28 01:17:53 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (1.49s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:54 DEBUG : b/potato: md5 = 42c12cca23ed3a99815542772c91e514 OK 2025/01/28 01:17:55 DEBUG : c/non empty space: md5 = 33e4792d12bb1e775afc0cd8ccd2c385 OK 2025/01/28 01:17:55 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/01/28 01:17:55 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/01/28 01:17:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:56 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:17:56 DEBUG : c/non empty space: Unchanged skipping 2025/01/28 01:17:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:56 DEBUG : a/potato2: md5 = 2cfb9cc2737279c1062117b50bf679a5 OK 2025/01/28 01:17:56 INFO : a/potato2: Copied (new) 2025/01/28 01:17:56 DEBUG : Waiting for deletions to finish 2025/01/28 01:17:57 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (3.99s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:59 DEBUG : empty space: md5 = 5d8b6c4b156a5796738f7ec458ddb068 OK 2025/01/28 01:17:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:59 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/01/28 01:17:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:59 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/01/28 01:17:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:17:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:17:59 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/01/28 01:17:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:17:59 DEBUG : empty space: md5 = 149070e6b116ecb4ff4d8d80b1c9053f OK 2025/01/28 01:17:59 INFO : empty space: Copied (replaced existing) 2025/01/28 01:17:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (2.22s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:1016: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.10s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:00 DEBUG : foo: md5 = ae5f110bef2928232a30623bbf17f86b OK 2025/01/28 01:18:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:01 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/01/28 01:18:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:01 DEBUG : foo: md5 = 2e92d9e5e4a5427d4958b4f5b30ba44d OK 2025/01/28 01:18:01 INFO : foo: Copied (replaced existing) 2025/01/28 01:18:01 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (1.57s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:02 DEBUG : empty space: md5 = fb896c5fe25e7b552057a32584bc3582 OK 2025/01/28 01:18:02 DEBUG : potato: Need to transfer - File not found at Destination 2025/01/28 01:18:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:02 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:02 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:03 DEBUG : potato: md5 = 50b0cb4238eb257d475a4b0c3b30d97d OK 2025/01/28 01:18:03 INFO : potato: Copied (new) 2025/01/28 01:18:03 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (1.83s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:04 DEBUG : potato: md5 = 7470b32b85964a214bc538b85b2ff63c OK 2025/01/28 01:18:04 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/01/28 01:18:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:04 DEBUG : potato: md5 = 3944f4a914a89f0d8f09f81dff7d7462 OK 2025/01/28 01:18:04 INFO : potato: Copied (replaced existing) 2025/01/28 01:18:04 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (1.21s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:05 DEBUG : potato: md5 = 84a06353706593ba477c1d8daa55b60d OK 2025/01/28 01:18:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:05 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/01/28 01:18:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:05 DEBUG : potato: md5 = aad4c23507d1c9edb89c932265f0cf47 OK 2025/01/28 01:18:05 INFO : potato: Copied (replaced existing) 2025/01/28 01:18:05 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (1.59s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:07 DEBUG : potato: md5 = f5d21aa80c290c379b4c5bd715f4db27 OK 2025/01/28 01:18:07 DEBUG : empty space: md5 = 7a157ced9b2690ca1d6a17c9d87eabdd OK 2025/01/28 01:18:07 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:18:07 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/01/28 01:18:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:07 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:07 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:07 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:07 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (1.42s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:08 DEBUG : potato: md5 = 8baecf12bf93bec5bfc72d8478997497 OK 2025/01/28 01:18:08 DEBUG : empty space: md5 = 52986ab59dfb7dbfe1e003c9793a3418 OK 2025/01/28 01:18:08 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:18:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:09 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:09 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:09 DEBUG : potato2: md5 = 1a511d5941c42affb3343d457a5a6bcb OK 2025/01/28 01:18:09 INFO : potato2: Copied (new) 2025/01/28 01:18:09 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:09 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.13s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:10 DEBUG : b/potato: md5 = f1f6c870bcf2fd105aca3609adc67f4c OK 2025/01/28 01:18:10 DEBUG : c/non empty space: md5 = d9406e87ee09bbaeeb2df58f8bddcb14 OK 2025/01/28 01:18:10 INFO : d: Making directory 2025/01/28 01:18:10 INFO : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2025/01/28 01:18:11 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/01/28 01:18:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:11 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:11 DEBUG : c/non empty space: Unchanged skipping 2025/01/28 01:18:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:11 DEBUG : a/potato2: md5 = 62d906420385f35637a099af216e698c OK 2025/01/28 01:18:11 INFO : a/potato2: Copied (new) 2025/01/28 01:18:11 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:11 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (2.56s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:13 DEBUG : b/potato: md5 = 233fc5fc89375985d8836bf79a187595 OK 2025/01/28 01:18:13 DEBUG : c/non empty space: md5 = f9ac869f1e16afa0e6a3bdf0ba670315 OK 2025/01/28 01:18:13 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/01/28 01:18:13 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/01/28 01:18:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:13 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:13 DEBUG : c/non empty space: Unchanged skipping 2025/01/28 01:18:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:14 DEBUG : a/potato2: md5 = 9eae1f65e34c38a9d1d8d2be4d7f62e5 OK 2025/01/28 01:18:14 INFO : a/potato2: Copied (new) 2025/01/28 01:18:14 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': not deleting files as there were IO errors 2025/01/28 01:18:14 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (2.56s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:15 DEBUG : potato: md5 = 6d9aa25fe75077a2ad605e6a0422eec4 OK 2025/01/28 01:18:15 DEBUG : empty space: md5 = b758cb077fcebfc48d6691511cbc927b OK 2025/01/28 01:18:16 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:16 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:18:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:16 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:16 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:16 DEBUG : potato2: md5 = e6318c14aeafa1be3f894b9ab6ea7a3d OK 2025/01/28 01:18:16 INFO : potato2: Copied (new) 2025/01/28 01:18:16 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (2.07s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:17 DEBUG : potato: md5 = ae1124790b83e2ad621d551e984e4553 OK 2025/01/28 01:18:18 DEBUG : empty space: md5 = 66ff237dba6a35ac41c11afa73a0df9b OK 2025/01/28 01:18:18 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:18 INFO : potato: Deleted 2025/01/28 01:18:18 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:18:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:18 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:18 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:19 DEBUG : potato2: md5 = 82556c87d63ef55e5bec297bc2afee55 OK 2025/01/28 01:18:19 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (3.12s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:20 DEBUG : potato: md5 = 17fbc7f05a7fea00db8e069a80d36c67 OK 2025/01/28 01:18:21 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:18:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:21 DEBUG : potato2: md5 = c404c11b0ec1fb81e9d0d556b5b69b37 OK 2025/01/28 01:18:21 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (3.31s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:24 DEBUG : potato2: md5 = 2feb2fdb178a91c5cee82c89731621f5 OK 2025/01/28 01:18:24 DEBUG : empty space: md5 = 9df06f618bc455a08bcabd13319c94aa OK 2025/01/28 01:18:24 DEBUG : enormous: Excluded (Size Filter) 2025/01/28 01:18:24 DEBUG : enormous: Excluded 2025/01/28 01:18:24 DEBUG : potato2: Excluded (Size Filter) 2025/01/28 01:18:24 DEBUG : potato2: Excluded 2025/01/28 01:18:24 DEBUG : potato2: Excluded (Size Filter) 2025/01/28 01:18:24 DEBUG : potato2: Excluded 2025/01/28 01:18:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:24 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:24 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:24 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:24 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:25 DEBUG : enormous: Excluded (Size Filter) 2025/01/28 01:18:25 DEBUG : enormous: Excluded 2025/01/28 01:18:25 DEBUG : potato2: Excluded (Size Filter) 2025/01/28 01:18:25 DEBUG : potato2: Excluded 2025/01/28 01:18:25 DEBUG : potato2: Excluded (Size Filter) 2025/01/28 01:18:25 DEBUG : potato2: Excluded 2025/01/28 01:18:25 DEBUG : Local file system at /tmp/rclone1663140297: Waiting for checks to finish 2025/01/28 01:18:25 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:25 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:25 DEBUG : Local file system at /tmp/rclone1663140297: Waiting for transfers to finish 2025/01/28 01:18:25 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:25 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncWithExclude (2.10s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:26 DEBUG : potato2: md5 = c434e27bc9f89d4fff3ef0727168131f OK 2025/01/28 01:18:26 DEBUG : empty space: md5 = 6b1bffd8b9447afafc652221886307f1 OK 2025/01/28 01:18:26 DEBUG : enormous: md5 = 43dc1f6d1bb9392d2402d18a30a391bc OK 2025/01/28 01:18:27 DEBUG : enormous: Excluded (Size Filter) 2025/01/28 01:18:27 DEBUG : enormous: Excluded 2025/01/28 01:18:27 DEBUG : potato2: Excluded (Size Filter) 2025/01/28 01:18:27 DEBUG : potato2: Excluded 2025/01/28 01:18:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:27 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:27 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:27 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:27 INFO : enormous: Deleted 2025/01/28 01:18:27 INFO : potato2: Deleted 2025/01/28 01:18:27 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:28 DEBUG : Local file system at /tmp/rclone1663140297: Waiting for checks to finish 2025/01/28 01:18:28 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:28 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:28 DEBUG : Local file system at /tmp/rclone1663140297: Waiting for transfers to finish 2025/01/28 01:18:28 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:28 INFO : potato2: Deleted 2025/01/28 01:18:28 INFO : enormous: Deleted 2025/01/28 01:18:28 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (2.59s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:29 DEBUG : one: md5 = 41c9dad60df24af646d1696097e591de OK 2025/01/28 01:18:29 DEBUG : two: md5 = d473eb1deecf4b410acf74109f7db84b OK 2025/01/28 01:18:30 DEBUG : three: md5 = d82cf826a5da5effea068cdc1ea144fa OK 2025/01/28 01:18:30 DEBUG : four: md5 = b98b430528927b09bfce77c65bdb8860 OK 2025/01/28 01:18:30 DEBUG : five: Need to transfer - File not found at Destination 2025/01/28 01:18:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:30 DEBUG : one: Destination is newer than source, skipping 2025/01/28 01:18:30 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/01/28 01:18:30 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/01/28 01:18:30 DEBUG : three: Sizes identical 2025/01/28 01:18:30 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/01/28 01:18:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:31 DEBUG : four: md5 = 25199464228fcea187798896a00bac8f OK 2025/01/28 01:18:31 INFO : four: Copied (replaced existing) 2025/01/28 01:18:31 DEBUG : two: md5 = 7aa165fe5f047f02c7e89f84df37bf7f OK 2025/01/28 01:18:31 INFO : two: Copied (replaced existing) 2025/01/28 01:18:31 DEBUG : five: md5 = 1b163f2655f6fc49e58918b137cdb90a OK 2025/01/28 01:18:31 INFO : five: Copied (new) 2025/01/28 01:18:31 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (3.94s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1466: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1466: 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-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2025/01/28 01:18:32 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Ignoring --track-renames as the source and destination do not have a common hash 2025/01/28 01:18:32 DEBUG : potato: Need to transfer - File not found at Destination 2025/01/28 01:18:32 DEBUG : yam: Need to transfer - File not found at Destination 2025/01/28 01:18:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:33 DEBUG : potato: md5 = be0c847aa5f64b11e3ccbdb31c1d3abf OK 2025/01/28 01:18:33 INFO : potato: Copied (new) 2025/01/28 01:18:33 DEBUG : yam: md5 = 83780c6e816281505e4187e2394056e4 OK 2025/01/28 01:18:33 INFO : yam: Copied (new) 2025/01/28 01:18:33 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:33 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Ignoring --track-renames as the source and destination do not have a common hash 2025/01/28 01:18:33 DEBUG : yaml: Need to transfer - File not found at Destination 2025/01/28 01:18:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:33 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:33 DEBUG : potato: Unchanged skipping 2025/01/28 01:18:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:34 DEBUG : yaml: md5 = 33f81f27f5fbb618a5233308308487a7 OK 2025/01/28 01:18:34 INFO : yaml: Copied (new) 2025/01/28 01:18:34 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:34 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (4.01s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2025/01/28 01:18:36 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Making map for --track-renames 2025/01/28 01:18:36 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Finished making map for --track-renames 2025/01/28 01:18:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:36 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/01/28 01:18:36 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/01/28 01:18:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for renames to finish 2025/01/28 01:18:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:36 DEBUG : yam: md5 = 5077d744863748977924cb3734376168 OK 2025/01/28 01:18:36 INFO : yam: Copied (new) 2025/01/28 01:18:36 DEBUG : potato: md5 = cfc64eeb1bd019b26d414700f8377142 OK 2025/01/28 01:18:36 INFO : potato: Copied (new) 2025/01/28 01:18:36 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:37 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Making map for --track-renames 2025/01/28 01:18:37 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Finished making map for --track-renames 2025/01/28 01:18:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:37 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:37 DEBUG : potato: Unchanged skipping 2025/01/28 01:18:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for renames to finish 2025/01/28 01:18:37 INFO : yam: Copied (server-side copy) to: yaml 2025/01/28 01:18:37 INFO : yam: Deleted 2025/01/28 01:18:37 INFO : yaml: Renamed from "yam" 2025/01/28 01:18:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:37 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (3.14s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2025/01/28 01:18:39 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Making map for --track-renames 2025/01/28 01:18:39 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Finished making map for --track-renames 2025/01/28 01:18:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:39 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/01/28 01:18:39 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/01/28 01:18:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for renames to finish 2025/01/28 01:18:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:40 DEBUG : potato: md5 = 3544f4998cf5b43e74aed240876ed4e3 OK 2025/01/28 01:18:40 INFO : potato: Copied (new) 2025/01/28 01:18:40 DEBUG : sub/yam: md5 = b82aa54bc962e731b621b05891dab8ce OK 2025/01/28 01:18:40 INFO : sub/yam: Copied (new) 2025/01/28 01:18:40 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:40 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:40 DEBUG : potato: Unchanged skipping 2025/01/28 01:18:40 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Making map for --track-renames 2025/01/28 01:18:40 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Finished making map for --track-renames 2025/01/28 01:18:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for renames to finish 2025/01/28 01:18:40 INFO : sub/yam: Copied (server-side copy) to: yam 2025/01/28 01:18:40 INFO : sub/yam: Deleted 2025/01/28 01:18:40 INFO : yam: Renamed from "sub/yam" 2025/01/28 01:18:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:40 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (2.57s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:42 DEBUG : Creating backend with remote "/tmp/rclone1663140297/dir1" 2025/01/28 01:18:42 DEBUG : Creating backend with remote "/tmp/rclone1663140297/dir2" 2025/01/28 01:18:42 DEBUG : Local file system at /tmp/rclone1663140297/dir2: Using server-side directory move 2025/01/28 01:18:42 INFO : Local file system at /tmp/rclone1663140297/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/01/28 01:18:42 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/01/28 01:18:42 INFO : file1.txt: Moved (server-side) 2025/01/28 01:18:42 DEBUG : Local file system at /tmp/rclone1663140297/dir2: Waiting for checks to finish 2025/01/28 01:18:42 DEBUG : Local file system at /tmp/rclone1663140297/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.10s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:18:42 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/01/28 01:18:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:43 DEBUG : sub dir/hello world: md5 = ce14986edcd006ee46a1b5658c151ea6 OK 2025/01/28 01:18:43 INFO : sub dir/hello world: Copied (new) 2025/01/28 01:18:43 INFO : sub dir/hello world: Deleted 2025/01/28 01:18:43 DEBUG : nested/sub dir/file: md5 = badfb26aa608e1a4b4177f96e4e55b38 OK 2025/01/28 01:18:43 INFO : nested/sub dir/file: Copied (new) 2025/01/28 01:18:43 INFO : nested/sub dir/file: Deleted 2025/01/28 01:18:43 INFO : sub dir: Removing directory 2025/01/28 01:18:43 INFO : nested/sub dir: Removing directory 2025/01/28 01:18:43 INFO : nested: Removing directory 2025/01/28 01:18:43 DEBUG : Local file system at /tmp/rclone1663140297: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (2.49s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/28 01:18:44 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/01/28 01:18:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:45 DEBUG : sub dir/hello world: md5 = a1943d28465ffca43418e8738349c5ff OK 2025/01/28 01:18:45 INFO : sub dir/hello world: Copied (new) 2025/01/28 01:18:45 INFO : sub dir/hello world: Deleted 2025/01/28 01:18:45 DEBUG : nested/sub dir/file: md5 = 5a09ece179309a3a4095b4a5ebf72fdf OK 2025/01/28 01:18:45 INFO : nested/sub dir/file: Copied (new) 2025/01/28 01:18:45 INFO : nested/sub dir/file: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (1.46s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:46 DEBUG : existing: Need to transfer - File not found at Destination 2025/01/28 01:18:46 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/01/28 01:18:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:46 DEBUG : existing: md5 = dbdaf8a499930220be23f06a3dfb5af2 OK 2025/01/28 01:18:46 INFO : existing: Copied (new) 2025/01/28 01:18:46 INFO : existing: Deleted 2025/01/28 01:18:46 DEBUG : existing-b: md5 = 8c0f299e4de1c54fddc794d5903b7720 OK 2025/01/28 01:18:46 INFO : existing-b: Copied (new) 2025/01/28 01:18:46 INFO : existing-b: Deleted 2025/01/28 01:18:47 DEBUG : existing: Destination exists, skipping 2025/01/28 01:18:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:18:47 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/01/28 01:18:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:18:47 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (2.34s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majumel8zemo" 2025/01/28 01:18:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majumel8zemo.bin" 2025/01/28 01:18:49 DEBUG : Swift container crypt path rclone-test-majumel8zemo.bin: Auto set use_segments_container to true 2025/01/28 01:18:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majumel8zemo" 2025/01/28 01:18:50 DEBUG : Swift container crypt path rclone-test-majumel8zemo: Auto set use_segments_container to true 2025/01/28 01:18:50 DEBUG : potato2: md5 = 116f846236a8dd9406f93a26de2a1ba2 OK 2025/01/28 01:18:50 DEBUG : empty space: md5 = 97377022a8dc96be81d83f916524ecdd OK 2025/01/28 01:18:51 DEBUG : potato3: md5 = 7a14d83cd507949f7dc4fafb820bcfbc OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo' -> Encrypted drive 'TestCryptSwift:rclone-test-majumel8zemo' 2025/01/28 01:18:52 DEBUG : empty space: md5 = adff12e39536457fabc36ba91a3aca42 OK 2025/01/28 01:18:52 DEBUG : potato3: md5 = 2f2a0b0879d8678c821ce9fd75c0b661 OK 2025/01/28 01:18:53 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:18:53 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/01/28 01:18:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majumel8zemo': Waiting for checks to finish 2025/01/28 01:18:53 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:18:53 DEBUG : empty space: Unchanged skipping 2025/01/28 01:18:53 INFO : empty space: Deleted 2025/01/28 01:18:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majumel8zemo': Waiting for transfers to finish 2025/01/28 01:18:53 INFO : potato3: Copied (server-side copy) 2025/01/28 01:18:53 INFO : potato3: Deleted 2025/01/28 01:18:54 INFO : potato2: Copied (server-side copy) 2025/01/28 01:18:54 INFO : potato2: Deleted 2025/01/28 01:18:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-rucateh6bitu" 2025/01/28 01:18:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rucateh6bitu.bin" 2025/01/28 01:18:55 DEBUG : Swift container crypt path rclone-test-rucateh6bitu.bin: Auto set use_segments_container to true 2025/01/28 01:18:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rucateh6bitu" 2025/01/28 01:18:56 DEBUG : Swift container crypt path rclone-test-rucateh6bitu: Auto set use_segments_container to true 2025/01/28 01:18:56 DEBUG : empty space: Need to transfer - File not found at Destination 2025/01/28 01:18:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:18:56 DEBUG : potato3: Need to transfer - File not found at Destination 2025/01/28 01:18:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rucateh6bitu': Waiting for checks to finish 2025/01/28 01:18:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rucateh6bitu': Waiting for transfers to finish 2025/01/28 01:18:57 INFO : potato2: Copied (server-side copy) 2025/01/28 01:18:57 INFO : potato3: Copied (server-side copy) 2025/01/28 01:18:57 INFO : potato3: Deleted 2025/01/28 01:18:57 INFO : potato2: Deleted 2025/01/28 01:18:58 INFO : empty space: Copied (server-side copy) 2025/01/28 01:18:58 INFO : empty space: Deleted 2025/01/28 01:18:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rucateh6bitu': Purge remote 2025/01/28 01:18:58 DEBUG : Waiting for deletions to finish 2025/01/28 01:18:58 INFO : potato2.bin: Deleted 2025/01/28 01:18:58 INFO : empty space.bin: Deleted 2025/01/28 01:18:58 INFO : potato3.bin: Deleted 2025/01/28 01:18:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majumel8zemo': Purge remote 2025/01/28 01:18:58 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (10.94s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:18:59 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kafemog4qece" 2025/01/28 01:18:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kafemog4qece.bin" 2025/01/28 01:19:00 DEBUG : Swift container crypt path rclone-test-kafemog4qece.bin: Auto set use_segments_container to true 2025/01/28 01:19:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kafemog4qece" 2025/01/28 01:19:01 DEBUG : Swift container crypt path rclone-test-kafemog4qece: Auto set use_segments_container to true 2025/01/28 01:19:01 DEBUG : potato2: md5 = 5229a3ef4a109d329d308c8c805da47a OK 2025/01/28 01:19:01 DEBUG : empty space: md5 = 9ae290cdab9cb12428cd7fe9c14f1281 OK 2025/01/28 01:19:02 DEBUG : potato3: md5 = a2c58d77205a6830264e0e1038a96496 OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo' -> Encrypted drive 'TestCryptSwift:rclone-test-kafemog4qece' 2025/01/28 01:19:03 DEBUG : empty space: md5 = 57ce6ebefbc0bf3237bd8a386661ae5c OK 2025/01/28 01:19:03 DEBUG : potato3: md5 = 5130de9a4d7711a812aeb59e8c185638 OK 2025/01/28 01:19:03 DEBUG : empty space: Excluded (Size Filter) 2025/01/28 01:19:03 DEBUG : empty space: Excluded 2025/01/28 01:19:03 DEBUG : empty space: Excluded (Size Filter) 2025/01/28 01:19:03 DEBUG : empty space: Excluded 2025/01/28 01:19:03 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:19:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kafemog4qece': Waiting for checks to finish 2025/01/28 01:19:03 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/01/28 01:19:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kafemog4qece': Waiting for transfers to finish 2025/01/28 01:19:04 INFO : potato3: Copied (server-side copy) 2025/01/28 01:19:04 INFO : potato2: Copied (server-side copy) 2025/01/28 01:19:04 INFO : potato3: Deleted 2025/01/28 01:19:04 INFO : potato2: Deleted 2025/01/28 01:19:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xexebaq6fuse" 2025/01/28 01:19:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xexebaq6fuse.bin" 2025/01/28 01:19:05 DEBUG : Swift container crypt path rclone-test-xexebaq6fuse.bin: Auto set use_segments_container to true 2025/01/28 01:19:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xexebaq6fuse" 2025/01/28 01:19:06 DEBUG : Swift container crypt path rclone-test-xexebaq6fuse: Auto set use_segments_container to true 2025/01/28 01:19:07 DEBUG : empty space: Excluded (Size Filter) 2025/01/28 01:19:07 DEBUG : empty space: Excluded 2025/01/28 01:19:07 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:19:07 DEBUG : potato3: Need to transfer - File not found at Destination 2025/01/28 01:19:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xexebaq6fuse': Waiting for checks to finish 2025/01/28 01:19:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xexebaq6fuse': Waiting for transfers to finish 2025/01/28 01:19:07 INFO : potato2: Copied (server-side copy) 2025/01/28 01:19:07 INFO : potato2: Deleted 2025/01/28 01:19:08 INFO : potato3: Copied (server-side copy) 2025/01/28 01:19:08 INFO : potato3: Deleted 2025/01/28 01:19:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xexebaq6fuse': Purge remote 2025/01/28 01:19:08 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:09 INFO : potato2.bin: Deleted 2025/01/28 01:19:09 INFO : potato3.bin: Deleted 2025/01/28 01:19:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kafemog4qece': Purge remote 2025/01/28 01:19:09 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:09 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (10.48s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-rerevik6ridu" 2025/01/28 01:19:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rerevik6ridu.bin" 2025/01/28 01:19:10 DEBUG : Swift container crypt path rclone-test-rerevik6ridu.bin: Auto set use_segments_container to true 2025/01/28 01:19:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rerevik6ridu" 2025/01/28 01:19:11 DEBUG : Swift container crypt path rclone-test-rerevik6ridu: Auto set use_segments_container to true 2025/01/28 01:19:12 DEBUG : potato2: md5 = 9f0cfbe8fb47b8d99ba636c8d3c649b5 OK 2025/01/28 01:19:12 DEBUG : empty space: md5 = cc504da9018cd7d1fbc3667511fa62cd OK 2025/01/28 01:19:12 DEBUG : potato3: md5 = 6669c436306d16216bbdbf53c59addd4 OK 2025/01/28 01:19:12 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo' -> Encrypted drive 'TestCryptSwift:rclone-test-rerevik6ridu' 2025/01/28 01:19:13 DEBUG : empty space: md5 = 22a6458799ff3d01ac07383fd63ca8df OK 2025/01/28 01:19:14 DEBUG : potato3: md5 = eb3d2002c430770099799dfa359cf48c OK 2025/01/28 01:19:15 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:19:15 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/01/28 01:19:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rerevik6ridu': Waiting for checks to finish 2025/01/28 01:19:15 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:19:15 DEBUG : empty space: Unchanged skipping 2025/01/28 01:19:15 INFO : empty space: Deleted 2025/01/28 01:19:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rerevik6ridu': Waiting for transfers to finish 2025/01/28 01:19:15 INFO : potato3: Copied (server-side copy) 2025/01/28 01:19:15 INFO : potato3: Deleted 2025/01/28 01:19:15 INFO : potato2: Copied (server-side copy) 2025/01/28 01:19:15 INFO : potato2: Deleted 2025/01/28 01:19:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-najoheh4zeba" 2025/01/28 01:19:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-najoheh4zeba.bin" 2025/01/28 01:19:17 DEBUG : Swift container crypt path rclone-test-najoheh4zeba.bin: Auto set use_segments_container to true 2025/01/28 01:19:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-najoheh4zeba" 2025/01/28 01:19:18 DEBUG : Swift container crypt path rclone-test-najoheh4zeba: Auto set use_segments_container to true 2025/01/28 01:19:18 INFO : tomatoDir: Making directory 2025/01/28 01:19:18 DEBUG : empty space: Need to transfer - File not found at Destination 2025/01/28 01:19:18 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/28 01:19:18 DEBUG : potato3: Need to transfer - File not found at Destination 2025/01/28 01:19:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-najoheh4zeba': Waiting for checks to finish 2025/01/28 01:19:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-najoheh4zeba': Waiting for transfers to finish 2025/01/28 01:19:18 INFO : empty space: Copied (server-side copy) 2025/01/28 01:19:18 INFO : potato3: Copied (server-side copy) 2025/01/28 01:19:19 INFO : potato3: Deleted 2025/01/28 01:19:19 INFO : empty space: Deleted 2025/01/28 01:19:19 INFO : potato2: Copied (server-side copy) 2025/01/28 01:19:19 INFO : potato2: Deleted 2025/01/28 01:19:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-najoheh4zeba': Purge remote 2025/01/28 01:19:19 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:20 INFO : potato3.bin: Deleted 2025/01/28 01:19:20 INFO : empty space.bin: Deleted 2025/01/28 01:19:20 INFO : potato2.bin: Deleted 2025/01/28 01:19:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rerevik6ridu': Purge remote 2025/01/28 01:19:20 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (10.93s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/rclone-move-test" 2025/01/28 01:19:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-move-test.bin" 2025/01/28 01:19:21 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-move-test.bin: Auto set use_segments_container to true 2025/01/28 01:19:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-move-test" 2025/01/28 01:19:22 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-move-test: Auto set use_segments_container to true 2025/01/28 01:19:23 DEBUG : potato2: md5 = 38d5f1c9184d2e19a6a54588ec957593 OK --- PASS: TestServerSideMoveOverlap (2.86s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:23 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test" 2025/01/28 01:19:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-sync-test.bin" 2025/01/28 01:19:24 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-sync-test.bin: Auto set use_segments_container to true 2025/01/28 01:19:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-sync-test" 2025/01/28 01:19:25 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncOverlap (2.62s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test" 2025/01/28 01:19:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-sync-test.bin" 2025/01/28 01:19:27 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-sync-test.bin: Auto set use_segments_container to true 2025/01/28 01:19:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-sync-test" 2025/01/28 01:19:27 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-sync-test: Auto set use_segments_container to true 2025/01/28 01:19:28 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test-include/layer2" 2025/01/28 01:19:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-sync-test-include/layer2.bin" 2025/01/28 01:19:28 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/01/28 01:19:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-sync-test-include/layer2" 2025/01/28 01:19:29 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/01/28 01:19:30 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test-ignore-file" 2025/01/28 01:19:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-sync-test-ignore-file.bin" 2025/01/28 01:19:30 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/01/28 01:19:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/rclone-sync-test-ignore-file" 2025/01/28 01:19:31 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/01/28 01:19:33 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = be684ce928bb2500adb0d9cfc4a14050 OK 2025/01/28 01:19:33 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/01/28 01:19:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test': Waiting for checks to finish 2025/01/28 01:19:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test': Waiting for transfers to finish 2025/01/28 01:19:33 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:33 INFO : There was nothing to transfer 2025/01/28 01:19:33 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/01/28 01:19:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:19:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:19:33 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:33 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:34 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/01/28 01:19:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/01/28 01:19:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/01/28 01:19:34 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:34 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:34 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/01/28 01:19:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:19:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:19:34 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:34 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:34 DEBUG : : Excluded 2025/01/28 01:19:34 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/01/28 01:19:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/01/28 01:19:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/01/28 01:19:34 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:34 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (11.29s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/dst" 2025/01/28 01:19:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst.bin" 2025/01/28 01:19:38 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst.bin: Auto set use_segments_container to true 2025/01/28 01:19:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst" 2025/01/28 01:19:39 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst: Auto set use_segments_container to true 2025/01/28 01:19:39 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/CompareDest" 2025/01/28 01:19:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/CompareDest.bin" 2025/01/28 01:19:40 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/CompareDest.bin: Auto set use_segments_container to true 2025/01/28 01:19:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/CompareDest" 2025/01/28 01:19:41 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/CompareDest: Auto set use_segments_container to true 2025/01/28 01:19:42 DEBUG : one: Need to transfer - File not found at Destination 2025/01/28 01:19:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:19:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:19:42 DEBUG : one: md5 = 0d815446aeaca95f00c745f401f12f0b OK 2025/01/28 01:19:42 INFO : one: Copied (new) 2025/01/28 01:19:42 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:43 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/28 01:19:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:19:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:19:43 DEBUG : one: md5 = c98f7961a487044f9f34d0cade74b384 OK 2025/01/28 01:19:43 INFO : one: Copied (replaced existing) 2025/01/28 01:19:43 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:44 DEBUG : dst/one: md5 = c6ced66a5637e405ffc726b6bdbb3373 OK 2025/01/28 01:19:44 DEBUG : CompareDest/one: md5 = a3ee36e6abf19e4ddaa8b8d91fec8141 OK 2025/01/28 01:19:45 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/28 01:19:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:19:45 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:19:45 DEBUG : one: Destination found in --compare-dest, skipping 2025/01/28 01:19:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:19:45 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:45 INFO : There was nothing to transfer 2025/01/28 01:19:45 DEBUG : CompareDest/two: md5 = 11e24797cf8cb3971e4ba77121d00465 OK 2025/01/28 01:19:46 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:19:46 DEBUG : two: Destination found in --compare-dest, skipping 2025/01/28 01:19:46 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/28 01:19:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:19:46 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:19:46 DEBUG : one: Destination found in --compare-dest, skipping 2025/01/28 01:19:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:19:46 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:46 INFO : There was nothing to transfer 2025/01/28 01:19:46 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:19:46 DEBUG : two: Destination found in --compare-dest, skipping 2025/01/28 01:19:46 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/28 01:19:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:19:46 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:19:46 DEBUG : one: Destination found in --compare-dest, skipping 2025/01/28 01:19:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:19:46 DEBUG : Waiting for deletions to finish 2025/01/28 01:19:46 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2025/01/28 01:19:47 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/01/28 01:19:47 DEBUG : two: Need to transfer - File not found at Destination 2025/01/28 01:19:47 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/28 01:19:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:19:47 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:19:47 DEBUG : one: Destination found in --compare-dest, skipping 2025/01/28 01:19:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:19:47 DEBUG : two: md5 = 138a293c71c0a43c0aa227e7059dd7fd OK 2025/01/28 01:19:47 INFO : two: Copied (new) 2025/01/28 01:19:47 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (10.91s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:49 DEBUG : pre-dest1/1: md5 = a06fb2636da9bfbc2681f9ba60fb6e7c OK 2025/01/28 01:19:49 DEBUG : pre-dest2/2: md5 = efd98a72371379f276a73ceb49ea3a35 OK 2025/01/28 01:19:49 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/dest" 2025/01/28 01:19:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dest.bin" 2025/01/28 01:19:50 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dest.bin: Auto set use_segments_container to true 2025/01/28 01:19:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dest" 2025/01/28 01:19:51 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dest: Auto set use_segments_container to true 2025/01/28 01:19:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/pre-dest1" 2025/01/28 01:19:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/pre-dest1.bin" 2025/01/28 01:19:52 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/pre-dest1.bin: Auto set use_segments_container to true 2025/01/28 01:19:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/pre-dest1" 2025/01/28 01:19:53 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/pre-dest1: Auto set use_segments_container to true 2025/01/28 01:19:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/pre-dest2" 2025/01/28 01:19:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/pre-dest2.bin" 2025/01/28 01:19:54 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/pre-dest2.bin: Auto set use_segments_container to true 2025/01/28 01:19:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/pre-dest2" 2025/01/28 01:19:55 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/pre-dest2: Auto set use_segments_container to true 2025/01/28 01:19:55 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:19:55 DEBUG : 1: Destination found in --compare-dest, skipping 2025/01/28 01:19:55 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:19:55 DEBUG : 2: Destination found in --compare-dest, skipping 2025/01/28 01:19:56 DEBUG : 3: Need to transfer - File not found at Destination 2025/01/28 01:19:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dest': Waiting for checks to finish 2025/01/28 01:19:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dest': Waiting for transfers to finish 2025/01/28 01:19:57 DEBUG : 3: md5 = ed9d6acdc641bcc6bde474431b9c3ee4 OK 2025/01/28 01:19:57 INFO : 3: Copied (new) 2025/01/28 01:19:57 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (9.77s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:19:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/dst" 2025/01/28 01:19:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst.bin" 2025/01/28 01:19:59 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst.bin: Auto set use_segments_container to true 2025/01/28 01:19:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst" 2025/01/28 01:19:59 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst: Auto set use_segments_container to true 2025/01/28 01:20:00 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/CopyDest" 2025/01/28 01:20:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/CopyDest.bin" 2025/01/28 01:20:00 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/CopyDest.bin: Auto set use_segments_container to true 2025/01/28 01:20:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/CopyDest" 2025/01/28 01:20:01 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/CopyDest: Auto set use_segments_container to true 2025/01/28 01:20:02 DEBUG : one: Need to transfer - File not found at Destination 2025/01/28 01:20:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:02 DEBUG : one: md5 = 028a80105e3b41dc876c16b247ce1d40 OK 2025/01/28 01:20:02 INFO : one: Copied (new) 2025/01/28 01:20:02 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/28 01:20:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:03 DEBUG : one: md5 = 40d0b0774180d7bed08ad4beaf18c22d OK 2025/01/28 01:20:03 INFO : one: Copied (replaced existing) 2025/01/28 01:20:03 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:03 DEBUG : dst/one: md5 = bfb32cabce99e8f0e2cd19a662b478cb OK 2025/01/28 01:20:03 DEBUG : CopyDest/one: md5 = 825e74f60a30eff7667e4a2a6e9bf2be OK 2025/01/28 01:20:03 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/BackupDir" 2025/01/28 01:20:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/BackupDir.bin" 2025/01/28 01:20:04 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/BackupDir.bin: Auto set use_segments_container to true 2025/01/28 01:20:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/BackupDir" 2025/01/28 01:20:05 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/BackupDir: Auto set use_segments_container to true 2025/01/28 01:20:06 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/28 01:20:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:06 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:06 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/28 01:20:07 INFO : one: Copied (server-side copy) 2025/01/28 01:20:07 INFO : one: Deleted 2025/01/28 01:20:08 INFO : one: Copied (server-side copy) 2025/01/28 01:20:08 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/01/28 01:20:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:08 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:08 DEBUG : CopyDest/two: md5 = 0a706b2369d3799fd746c977a3235c1c OK 2025/01/28 01:20:09 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:09 INFO : two: Copied (server-side copy) 2025/01/28 01:20:09 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/01/28 01:20:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:09 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:09 DEBUG : one: Unchanged skipping 2025/01/28 01:20:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:09 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:09 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:09 DEBUG : one: Unchanged skipping 2025/01/28 01:20:09 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:09 DEBUG : two: Unchanged skipping 2025/01/28 01:20:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:09 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:09 INFO : There was nothing to transfer 2025/01/28 01:20:12 DEBUG : CopyDest/three: md5 = df5f8f6d15c065055c0859b16985fcff OK 2025/01/28 01:20:12 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/01/28 01:20:12 DEBUG : three: Destination not found in --copy-dest 2025/01/28 01:20:12 DEBUG : three: Need to transfer - File not found at Destination 2025/01/28 01:20:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:12 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:12 DEBUG : one: Unchanged skipping 2025/01/28 01:20:12 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:12 DEBUG : two: Unchanged skipping 2025/01/28 01:20:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:13 DEBUG : three: md5 = a5f4e03ae40f96791f8499c995dc4768 OK 2025/01/28 01:20:13 INFO : three: Copied (new) 2025/01/28 01:20:13 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (16.67s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:20:15 DEBUG : dst/one: md5 = de05a5d1d1e4a1b4a6f75bf769e5ff5f OK 2025/01/28 01:20:15 DEBUG : dst/two: md5 = 235e487591f05d6f031487f2da441bea OK 2025/01/28 01:20:16 DEBUG : dst/three.txt: md5 = d2c13dc8bbee0d5183ef5306ef031ffd OK 2025/01/28 01:20:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst.bin" 2025/01/28 01:20:17 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst.bin: Auto set use_segments_container to true 2025/01/28 01:20:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:18 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst: Auto set use_segments_container to true 2025/01/28 01:20:18 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/backup" 2025/01/28 01:20:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/backup.bin" 2025/01/28 01:20:18 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/backup.bin: Auto set use_segments_container to true 2025/01/28 01:20:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/backup" 2025/01/28 01:20:19 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/backup: Auto set use_segments_container to true 2025/01/28 01:20:19 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/01/28 01:20:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:20 DEBUG : two: Unchanged skipping 2025/01/28 01:20:21 INFO : one: Copied (server-side copy) 2025/01/28 01:20:21 INFO : one: Deleted 2025/01/28 01:20:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:21 DEBUG : one: md5 = 0e8a1c604f85015395bb272f9a11d2d8 OK 2025/01/28 01:20:21 INFO : one: Copied (new) 2025/01/28 01:20:21 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:21 INFO : three.txt: Copied (server-side copy) 2025/01/28 01:20:21 INFO : three.txt: Deleted 2025/01/28 01:20:21 INFO : three.txt: Moved into backup dir 2025/01/28 01:20:22 DEBUG : dst/three.txt: md5 = f2ab75ba18f8b13420c07fa4507d8786 OK 2025/01/28 01:20:22 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/01/28 01:20:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:23 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:23 DEBUG : two: Unchanged skipping 2025/01/28 01:20:23 INFO : one: Copied (server-side copy) 2025/01/28 01:20:23 INFO : one: Deleted 2025/01/28 01:20:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:23 DEBUG : one: md5 = 7fdf1641a1dd7a87945cadbd52740a52 OK 2025/01/28 01:20:23 INFO : one: Copied (new) 2025/01/28 01:20:23 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:23 INFO : three.txt: Copied (server-side copy) 2025/01/28 01:20:24 INFO : three.txt: Deleted 2025/01/28 01:20:24 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (10.25s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:20:25 DEBUG : dst/one: md5 = ca18998e72d0099f62bb0a2081c30dfa OK 2025/01/28 01:20:25 DEBUG : dst/two: md5 = b9198849599a5026850539bf5f32a7c8 OK 2025/01/28 01:20:26 DEBUG : dst/three.txt: md5 = 516ba19991f7b6889024f1e383cdbe8d OK 2025/01/28 01:20:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst.bin" 2025/01/28 01:20:27 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst.bin: Auto set use_segments_container to true 2025/01/28 01:20:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:27 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst: Auto set use_segments_container to true 2025/01/28 01:20:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/backup" 2025/01/28 01:20:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/backup.bin" 2025/01/28 01:20:28 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/backup.bin: Auto set use_segments_container to true 2025/01/28 01:20:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/backup" 2025/01/28 01:20:29 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/backup: Auto set use_segments_container to true 2025/01/28 01:20:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/01/28 01:20:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:29 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:29 DEBUG : two: Unchanged skipping 2025/01/28 01:20:30 INFO : one: Copied (server-side copy) to: one.bak 2025/01/28 01:20:30 INFO : one: Deleted 2025/01/28 01:20:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:30 DEBUG : one: md5 = 710f972a52a396fcd19fea7d93fb9b69 OK 2025/01/28 01:20:30 INFO : one: Copied (new) 2025/01/28 01:20:30 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:31 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/01/28 01:20:31 INFO : three.txt: Deleted 2025/01/28 01:20:31 INFO : three.txt: Moved into backup dir 2025/01/28 01:20:32 DEBUG : dst/three.txt: md5 = 7c066b826b78cf352f775d93726247e7 OK 2025/01/28 01:20:32 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/01/28 01:20:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:32 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:32 DEBUG : two: Unchanged skipping 2025/01/28 01:20:32 INFO : one: Copied (server-side copy) to: one.bak 2025/01/28 01:20:32 INFO : one: Deleted 2025/01/28 01:20:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:33 DEBUG : one: md5 = bc203164b3e817cae4a71105ba7d15dd OK 2025/01/28 01:20:33 INFO : one: Copied (new) 2025/01/28 01:20:33 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:33 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/01/28 01:20:33 INFO : three.txt: Deleted 2025/01/28 01:20:33 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (9.32s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:20:34 DEBUG : dst/one: md5 = 44af9f5a6c1803d43f115dc868692e3a OK 2025/01/28 01:20:35 DEBUG : dst/two: md5 = 1948519af576998865a027f0a31e292e OK 2025/01/28 01:20:35 DEBUG : dst/three.txt: md5 = c6a83e86208cdf63f8d5cab363d53dbe OK 2025/01/28 01:20:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst.bin" 2025/01/28 01:20:36 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst.bin: Auto set use_segments_container to true 2025/01/28 01:20:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:36 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst: Auto set use_segments_container to true 2025/01/28 01:20:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/backup" 2025/01/28 01:20:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/backup.bin" 2025/01/28 01:20:37 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/backup.bin: Auto set use_segments_container to true 2025/01/28 01:20:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/backup" 2025/01/28 01:20:38 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/backup: Auto set use_segments_container to true 2025/01/28 01:20:38 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/01/28 01:20:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:38 DEBUG : two: Unchanged skipping 2025/01/28 01:20:39 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/01/28 01:20:39 INFO : one: Deleted 2025/01/28 01:20:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:40 DEBUG : one: md5 = 076c49ddb697c1c7df5d79f6fce982ce OK 2025/01/28 01:20:40 INFO : one: Copied (new) 2025/01/28 01:20:40 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:41 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/01/28 01:20:41 INFO : three.txt: Deleted 2025/01/28 01:20:41 INFO : three.txt: Moved into backup dir 2025/01/28 01:20:42 DEBUG : dst/three.txt: md5 = abe1ade866ea2b603297db797ad8b107 OK 2025/01/28 01:20:42 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/01/28 01:20:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:42 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:42 DEBUG : two: Unchanged skipping 2025/01/28 01:20:43 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/01/28 01:20:43 INFO : one: Deleted 2025/01/28 01:20:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:43 DEBUG : one: md5 = f924357e86cecb33396eee033ab6166d OK 2025/01/28 01:20:43 INFO : one: Copied (new) 2025/01/28 01:20:43 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:43 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/01/28 01:20:43 INFO : three.txt: Deleted 2025/01/28 01:20:43 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (10.22s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:20:45 DEBUG : dst/one: md5 = 374a79719c9d9c4b3fc30692b481797f OK 2025/01/28 01:20:45 DEBUG : dst/two: md5 = a24bef2bc35ea8f00bfe01b30ea6e3d3 OK 2025/01/28 01:20:45 DEBUG : dst/three.txt: md5 = 29a478048ba60e6c065d095a94ec4f5e OK 2025/01/28 01:20:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst.bin" 2025/01/28 01:20:46 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst.bin: Auto set use_segments_container to true 2025/01/28 01:20:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:47 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst: Auto set use_segments_container to true 2025/01/28 01:20:47 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/01/28 01:20:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:47 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:47 DEBUG : two: Unchanged skipping 2025/01/28 01:20:47 INFO : one: Copied (server-side copy) to: one.bak 2025/01/28 01:20:48 INFO : one: Deleted 2025/01/28 01:20:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:48 DEBUG : one: md5 = 0fe6e553f530a9746fef3591b0650a21 OK 2025/01/28 01:20:48 INFO : one: Copied (new) 2025/01/28 01:20:48 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:48 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/01/28 01:20:49 INFO : three.txt: Deleted 2025/01/28 01:20:49 INFO : three.txt: Moved into backup dir 2025/01/28 01:20:49 DEBUG : dst/three.txt: md5 = ad54e3c2c747f174160de2da184c1c33 OK 2025/01/28 01:20:50 DEBUG : one.bak: Excluded (Path Filter) 2025/01/28 01:20:50 DEBUG : one.bak: Excluded 2025/01/28 01:20:50 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/01/28 01:20:50 DEBUG : three.txt.bak: Excluded 2025/01/28 01:20:50 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/01/28 01:20:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for checks to finish 2025/01/28 01:20:50 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:50 DEBUG : two: Unchanged skipping 2025/01/28 01:20:50 INFO : one: Copied (server-side copy) to: one.bak 2025/01/28 01:20:50 INFO : one: Deleted 2025/01/28 01:20:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo/dst': Waiting for transfers to finish 2025/01/28 01:20:50 DEBUG : one: md5 = 9d8984dc12a8387e98befa3815652d63 OK 2025/01/28 01:20:50 INFO : one: Copied (new) 2025/01/28 01:20:50 DEBUG : Waiting for deletions to finish 2025/01/28 01:20:51 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/01/28 01:20:51 INFO : three.txt: Deleted 2025/01/28 01:20:51 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (7.70s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:20:52 DEBUG : dst/one: md5 = 164d8ce30543b31231636664bee3fd99 OK 2025/01/28 01:20:52 DEBUG : dst/two: md5 = 3f1e18b357852300a5338db1136e049e OK 2025/01/28 01:20:53 DEBUG : dst/three.txt: md5 = d24237f7bb16d257234cb35063b4ba33 OK 2025/01/28 01:20:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst.bin" 2025/01/28 01:20:54 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst.bin: Auto set use_segments_container to true 2025/01/28 01:20:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst" 2025/01/28 01:20:54 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst: Auto set use_segments_container to true 2025/01/28 01:20:55 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/01/28 01:20:55 INFO : one: Copied (server-side copy) to: one.bak 2025/01/28 01:20:55 INFO : one: Deleted 2025/01/28 01:20:55 DEBUG : one: md5 = b1201200f735db98ac9dfc6c0c984227 OK 2025/01/28 01:20:55 INFO : one: Copied (new) 2025/01/28 01:20:55 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:55 DEBUG : two: Unchanged skipping 2025/01/28 01:20:55 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/01/28 01:20:55 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/01/28 01:20:56 INFO : three.txt: Deleted 2025/01/28 01:20:56 DEBUG : three.txt: md5 = fde8ec36aacc5e2af94744338e1b5ecf OK 2025/01/28 01:20:56 INFO : three.txt: Copied (new) 2025/01/28 01:20:57 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/01/28 01:20:57 INFO : one: Copied (server-side copy) to: one.bak 2025/01/28 01:20:57 INFO : one: Deleted 2025/01/28 01:20:57 DEBUG : one: md5 = 4439dbbb44a20628d28beb7235e4beca OK 2025/01/28 01:20:57 INFO : one: Copied (new) 2025/01/28 01:20:57 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:20:57 DEBUG : two: Unchanged skipping 2025/01/28 01:20:57 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/01/28 01:20:58 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/01/28 01:20:58 INFO : three.txt: Deleted 2025/01/28 01:20:58 DEBUG : three.txt: md5 = a0c754704c2adae2daa38f6c847b498b OK 2025/01/28 01:20:58 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (7.20s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:21:00 DEBUG : dst/one: md5 = eaffbac93885d3354805fc545a518915 OK 2025/01/28 01:21:00 DEBUG : dst/two: md5 = 2bd9b0839ca7de4cfbcd07ee8850c457 OK 2025/01/28 01:21:00 DEBUG : dst/three.txt: md5 = f3639c1ea582f246b5e27ed2bdddc57c OK 2025/01/28 01:21:00 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yexadin9vuwo/dst" 2025/01/28 01:21:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst.bin" 2025/01/28 01:21:01 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst.bin: Auto set use_segments_container to true 2025/01/28 01:21:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yexadin9vuwo/dst" 2025/01/28 01:21:02 DEBUG : Swift container crypt path rclone-test-yexadin9vuwo/dst: Auto set use_segments_container to true 2025/01/28 01:21:02 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/01/28 01:21:02 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/01/28 01:21:02 INFO : one: Deleted 2025/01/28 01:21:03 DEBUG : one: md5 = a5c5caa12bf21b7da4165b1f9b4a28c6 OK 2025/01/28 01:21:03 INFO : one: Copied (new) 2025/01/28 01:21:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:03 DEBUG : two: Unchanged skipping 2025/01/28 01:21:03 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/01/28 01:21:03 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/01/28 01:21:03 INFO : three.txt: Deleted 2025/01/28 01:21:03 DEBUG : three.txt: md5 = 5b85f94fe068590b23b74658f51b066a OK 2025/01/28 01:21:03 INFO : three.txt: Copied (new) 2025/01/28 01:21:04 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/01/28 01:21:05 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/01/28 01:21:05 INFO : one: Deleted 2025/01/28 01:21:05 DEBUG : one: md5 = be5a9d618da08cccbfe4628abaab47b7 OK 2025/01/28 01:21:05 INFO : one: Copied (new) 2025/01/28 01:21:05 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:05 DEBUG : two: Unchanged skipping 2025/01/28 01:21:05 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/01/28 01:21:05 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/01/28 01:21:05 INFO : three.txt: Deleted 2025/01/28 01:21:06 DEBUG : three.txt: md5 = 1ece0d2734c4cf91a9fca457a64407ea OK 2025/01/28 01:21:06 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (7.71s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:21:08 DEBUG : Testêé: md5 = 72dab2cad3b80fabe69d15bcf6188602 OK 2025/01/28 01:21:08 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/01/28 01:21:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:21:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:21:08 DEBUG : Testêé: md5 = 40130aea4f3385bcbd795c284311f0ff OK 2025/01/28 01:21:08 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/01/28 01:21:08 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (1.98s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:21:09 DEBUG : existing: Need to transfer - File not found at Destination 2025/01/28 01:21:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:21:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:21:10 DEBUG : existing: md5 = 04df8a7d23ed48a3737fa1441c9dbcd1 OK 2025/01/28 01:21:10 INFO : existing: Copied (new) 2025/01/28 01:21:10 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:21:10 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/01/28 01:21:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:21:10 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/01/28 01:21:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:21:10 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': not deleting files as there were IO errors 2025/01/28 01:21:10 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncImmutable (1.87s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:21:12 DEBUG : EXISTING: md5 = 77db25e73f236e5d939a7af37424ef16 OK 2025/01/28 01:21:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:21:12 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:12 DEBUG : existing: Unchanged skipping 2025/01/28 01:21:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:21:12 DEBUG : Waiting for deletions to finish 2025/01/28 01:21:12 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.87s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.29s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.29s) --- SKIP: TestMaxTransfer/Hard (0.10s) --- SKIP: TestMaxTransfer/Soft (0.09s) --- SKIP: TestMaxTransfer/Cautious (0.10s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:21:14 DEBUG : both0: md5 = 8b4542340340108a718d108324c7c6f7 OK 2025/01/28 01:21:14 DEBUG : only0: md5 = 60ee02f340804ddd9ff8a3e8d1961c77 OK 2025/01/28 01:21:14 DEBUG : both1: md5 = 4c04e62c5b25db6b89bbead89d264540 OK 2025/01/28 01:21:15 DEBUG : only1: md5 = eb4f0017952f060a275856e426126017 OK 2025/01/28 01:21:15 DEBUG : both2: md5 = 562552872e47e1bba763fc351b784609 OK 2025/01/28 01:21:16 DEBUG : only2: md5 = 001551abe92ac4217fa3d3ec1250ab60 OK 2025/01/28 01:21:16 DEBUG : both3: md5 = eb73cc1046109056f6e47fd8a191493b OK 2025/01/28 01:21:16 DEBUG : only3: md5 = 7180dbc4ea2c6d60663bbcc5e235baf1 OK 2025/01/28 01:21:17 DEBUG : both4: md5 = 53a1b1ec5ec92e279b0b87bea3199f2b OK 2025/01/28 01:21:17 DEBUG : only4: md5 = 23a35ac81796741efe74fd628575a315 OK 2025/01/28 01:21:17 DEBUG : both5: md5 = 60f9016245b173836714df2085f45fba OK 2025/01/28 01:21:18 DEBUG : only5: md5 = 2790525653fd2445074480d3f7db031c OK 2025/01/28 01:21:19 DEBUG : both6: md5 = 2f1a7d7a271c8671bb77a6fb5e0e7714 OK 2025/01/28 01:21:20 DEBUG : only6: md5 = 251f050c00ce1aa1136312d6173ccb14 OK 2025/01/28 01:21:20 DEBUG : both7: md5 = 1269b3fafb24fb0ca814e92c9f606460 OK 2025/01/28 01:21:21 DEBUG : only7: md5 = 84c32a8a2f7563000052c1b7a18663d1 OK 2025/01/28 01:21:21 DEBUG : both8: md5 = 1f923b44309a2dd3bcc6264a90d63970 OK 2025/01/28 01:21:21 DEBUG : only8: md5 = 61efac60d108ef8a8201afa999c107ad OK 2025/01/28 01:21:22 DEBUG : both9: md5 = 599ded954ac351fe33aeb3d12f5f7bbf OK 2025/01/28 01:21:23 DEBUG : only9: md5 = 1d0d117f3ab9878a930e638d893476b1 OK 2025/01/28 01:21:23 DEBUG : both10: md5 = 50a73ee6346445d679dd92629d8b0a22 OK 2025/01/28 01:21:24 DEBUG : only10: md5 = a0a6aca0f84611cff291b0188136c2f3 OK 2025/01/28 01:21:24 DEBUG : both11: md5 = 95589a6271d3c6ad92329350afcda897 OK 2025/01/28 01:21:24 DEBUG : only11: md5 = d4a5466b091697732a06653a05a3dcad OK 2025/01/28 01:21:25 DEBUG : both12: md5 = 64ed64ce1c78000073a99d6640ce3461 OK 2025/01/28 01:21:25 DEBUG : only12: md5 = 8b52cba0a7e0a8067fdc14597fd0cbb4 OK 2025/01/28 01:21:26 DEBUG : both13: md5 = df84a831579f822b293a8ebf852672ba OK 2025/01/28 01:21:26 DEBUG : only13: md5 = a2135debaeda5ed511c52962c7dd734e OK 2025/01/28 01:21:26 DEBUG : both14: md5 = 087dbb8ad9bd011e52b7a0a895fb87f4 OK 2025/01/28 01:21:27 DEBUG : only14: md5 = 61690a56fed51f0448c7de18025ce51b OK 2025/01/28 01:21:27 DEBUG : both15: md5 = 0c577d46c05e2ec6b22276bce700e935 OK 2025/01/28 01:21:27 DEBUG : only15: md5 = b398a91ba8a0afda0fbdddbc8c9371b1 OK 2025/01/28 01:21:28 DEBUG : both16: md5 = 3af9fa49f3bc71bfa9416e77b7cc735f OK 2025/01/28 01:21:28 DEBUG : only16: md5 = 0bf7efba26938733ade935f31bfd4653 OK 2025/01/28 01:21:29 DEBUG : both17: md5 = a6dcfb084df195c65c4587f64772fa9f OK 2025/01/28 01:21:30 DEBUG : only17: md5 = 490e2c54876ab47550b573664365106c OK 2025/01/28 01:21:30 DEBUG : both18: md5 = 8a6694a370ad8533d489e942183663eb OK 2025/01/28 01:21:30 DEBUG : only18: md5 = 9625330973c67eb8c1dc8e650c5febaf OK 2025/01/28 01:21:31 DEBUG : both19: md5 = 2e7db6750c6db592d06b9a2d03e47a14 OK 2025/01/28 01:21:31 DEBUG : only19: md5 = 733f6300dba1ed431fd7b03fd0548e66 OK 2025/01/28 01:21:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:21:33 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:33 DEBUG : both0: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both1: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both11: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both10: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both12: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both13: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both14: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both15: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both17: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both16: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both18: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both19: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both2: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both3: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both4: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both5: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both6: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both7: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both8: Unchanged skipping 2025/01/28 01:21:34 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:34 DEBUG : both9: Unchanged skipping 2025/01/28 01:21:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:21:34 DEBUG : Waiting for deletions to finish 2025/01/28 01:21:34 INFO : only3: Deleted 2025/01/28 01:21:34 INFO : only13: Deleted 2025/01/28 01:21:34 INFO : only4: Deleted 2025/01/28 01:21:34 INFO : only19: Deleted 2025/01/28 01:21:34 INFO : only9: Deleted 2025/01/28 01:21:34 INFO : only18: Deleted 2025/01/28 01:21:34 INFO : only6: Deleted 2025/01/28 01:21:34 INFO : only7: Deleted 2025/01/28 01:21:34 INFO : only17: Deleted 2025/01/28 01:21:34 INFO : only11: Deleted 2025/01/28 01:21:34 INFO : only12: Deleted 2025/01/28 01:21:34 INFO : only0: Deleted 2025/01/28 01:21:34 INFO : only2: Deleted 2025/01/28 01:21:34 INFO : only10: Deleted 2025/01/28 01:21:34 INFO : only5: Deleted 2025/01/28 01:21:35 INFO : only14: Deleted 2025/01/28 01:21:35 INFO : only15: Deleted 2025/01/28 01:21:35 INFO : only1: Deleted 2025/01/28 01:21:35 INFO : only16: Deleted 2025/01/28 01:21:35 INFO : only8: Deleted 2025/01/28 01:21:35 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (25.87s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:21:39 DEBUG : both0: md5 = f3253bcabe433a607742900be6ff9e1b OK 2025/01/28 01:21:40 DEBUG : only0: md5 = 62942f77ffd5d7984729d6ce055de4bb OK 2025/01/28 01:21:40 DEBUG : both1: md5 = 28cb298dbca9f0607ef2c0f4c9061252 OK 2025/01/28 01:21:40 DEBUG : only1: md5 = 6259391d51b062bde97d6c59ff2e0360 OK 2025/01/28 01:21:40 DEBUG : both2: md5 = 398341a6bf0f056a6c1c2f970437977a OK 2025/01/28 01:21:40 DEBUG : only2: md5 = 97dbdf458192189e8ddd67f27e74d33a OK 2025/01/28 01:21:41 DEBUG : both3: md5 = 9dae41b581b703ac36d6d7300f491d23 OK 2025/01/28 01:21:41 DEBUG : only3: md5 = 1d5f282551bd19db1ee34156e793c2c5 OK 2025/01/28 01:21:41 DEBUG : both4: md5 = cfa679257c5e691cc73dcbb5adf67a1a OK 2025/01/28 01:21:41 DEBUG : only4: md5 = 5b4a5f9b72a24007455dc2a2539f90d7 OK 2025/01/28 01:21:42 DEBUG : both5: md5 = e1a97b8098953bc8615e737a89801bfe OK 2025/01/28 01:21:42 DEBUG : only5: md5 = 3b7b4bc0bfc03296f7bbb9748dd8ce7f OK 2025/01/28 01:21:42 DEBUG : both6: md5 = 5dd5615510256ee404f995612d9eabce OK 2025/01/28 01:21:42 DEBUG : only6: md5 = db01ae8f9ca3e3ad0b4978c78c0df1fb OK 2025/01/28 01:21:42 DEBUG : both7: md5 = 711c7fd14750f036d01343d0b509f214 OK 2025/01/28 01:21:43 DEBUG : only7: md5 = 7b9062cbbe0ee2e5ab635528a5febe6e OK 2025/01/28 01:21:43 DEBUG : both8: md5 = 01a9e95b21e77781151f7651c70f4ad9 OK 2025/01/28 01:21:43 DEBUG : only8: md5 = 52545fb43edc11490ea5c47f6c429487 OK 2025/01/28 01:21:43 DEBUG : both9: md5 = e051720b69fc91cd10609b63eb6ebf8e OK 2025/01/28 01:21:44 DEBUG : only9: md5 = 4223aa270f86392493908993793f3f33 OK 2025/01/28 01:21:44 DEBUG : both10: md5 = 4eac612ed752740cf9b639529fc5d479 OK 2025/01/28 01:21:44 DEBUG : only10: md5 = 4b685931b9445c752dc7302a555a0d49 OK 2025/01/28 01:21:44 DEBUG : both11: md5 = 15084602dc96add0220f52490ce84fcc OK 2025/01/28 01:21:44 DEBUG : only11: md5 = ea4a91c2f010ebd5310c87ec1ca3f952 OK 2025/01/28 01:21:44 DEBUG : both12: md5 = e6f812318665cb50ecb449f9986854af OK 2025/01/28 01:21:45 DEBUG : only12: md5 = 04dcfb37555b8b82e159e0ba69ea503b OK 2025/01/28 01:21:45 DEBUG : both13: md5 = e0a94b9c9596b92d191e7c5a323b11d5 OK 2025/01/28 01:21:45 DEBUG : only13: md5 = 50e637b1db25ea1151de345d5dfa8fdf OK 2025/01/28 01:21:45 DEBUG : both14: md5 = 607ca85cde2bad39bf87ab16e460eac5 OK 2025/01/28 01:21:45 DEBUG : only14: md5 = 96282e9ed55b698e154fc80007418c41 OK 2025/01/28 01:21:45 DEBUG : both15: md5 = bdcdffd2c30193f887fda3ef35df40db OK 2025/01/28 01:21:46 DEBUG : only15: md5 = 61d10b9a57f95e671ba1e1e0dcd0fd88 OK 2025/01/28 01:21:46 DEBUG : both16: md5 = 9506759a75177fe711c8bf47d1ef1f62 OK 2025/01/28 01:21:46 DEBUG : only16: md5 = a7a5ebb9f94582ea5bc76faa7c7c8f8a OK 2025/01/28 01:21:46 DEBUG : both17: md5 = 05e7b869472291f0e4df573bcae7fa41 OK 2025/01/28 01:21:46 DEBUG : only17: md5 = 32c93a5eacc1cd1a7850497b077c829a OK 2025/01/28 01:21:47 DEBUG : both18: md5 = bc1401c5de0270d6fbb2a675c87b6ed4 OK 2025/01/28 01:21:47 DEBUG : only18: md5 = d52f5ae3f285ba6ac765745056d4509d OK 2025/01/28 01:21:47 DEBUG : both19: md5 = 19e67c81b6dabf2ed8cde60c48c1e6ad OK 2025/01/28 01:21:48 DEBUG : only19: md5 = 508611a2076c52aa438da82f45843f93 OK 2025/01/28 01:21:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for checks to finish 2025/01/28 01:21:50 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both0: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both10: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both11: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both1: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both13: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both14: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both12: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both15: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both17: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both16: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both19: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both18: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both2: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both3: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both4: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both5: Unchanged skipping 2025/01/28 01:21:50 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both6: Unchanged skipping 2025/01/28 01:21:50 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/28 01:21:50 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : both7: Unchanged skipping 2025/01/28 01:21:50 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : both9: Unchanged skipping 2025/01/28 01:21:50 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/01/28 01:21:50 DEBUG : both8: Unchanged skipping 2025/01/28 01:21:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Waiting for transfers to finish 2025/01/28 01:21:50 DEBUG : only0: md5 = 3f97554e4b5f52bdcbb8f2df4ab35cb7 OK 2025/01/28 01:21:50 INFO : only0: Copied (replaced existing) 2025/01/28 01:21:50 DEBUG : only10: md5 = 814c141a60cc505155247a45e6610611 OK 2025/01/28 01:21:50 INFO : only10: Copied (replaced existing) 2025/01/28 01:21:50 DEBUG : only1: md5 = 3a44ac547b2aa2a33b2b128e16369131 OK 2025/01/28 01:21:50 INFO : only1: Copied (replaced existing) 2025/01/28 01:21:50 DEBUG : only11: md5 = a0406bd6f11f7ccf573e62a0b360ea06 OK 2025/01/28 01:21:50 INFO : only11: Copied (replaced existing) 2025/01/28 01:21:50 DEBUG : only12: md5 = bb9c3a37fac44c72b444f633e4e23a51 OK 2025/01/28 01:21:50 INFO : only12: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only13: md5 = d8893d3f1f69740a91cddcd9ebc0c3e1 OK 2025/01/28 01:21:51 INFO : only13: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only14: md5 = ab6f22d2ad203ef497996c8d3541a384 OK 2025/01/28 01:21:51 INFO : only14: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only15: md5 = c27c12966b9688a934ce0b56e797ea75 OK 2025/01/28 01:21:51 INFO : only15: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only16: md5 = 0ed33df0345c2885ca1585bac82aa605 OK 2025/01/28 01:21:51 INFO : only16: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only18: md5 = a52f45d63239126eb0e17e0c632d7a70 OK 2025/01/28 01:21:51 INFO : only18: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only17: md5 = 73e819184c5cbb3862cf34992439fd9d OK 2025/01/28 01:21:51 INFO : only17: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only19: md5 = f68e91c3d6175c9ae40d02fd92024736 OK 2025/01/28 01:21:51 INFO : only19: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only2: md5 = a012b50630d419a7f033ecd5db037a04 OK 2025/01/28 01:21:51 INFO : only2: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only4: md5 = d4749ed06eb289d8c7f2adc206e166c2 OK 2025/01/28 01:21:51 INFO : only4: Copied (replaced existing) 2025/01/28 01:21:51 DEBUG : only5: md5 = 6f741432431c8e4d9a92d62784fc7681 OK 2025/01/28 01:21:51 INFO : only5: Copied (replaced existing) 2025/01/28 01:21:52 DEBUG : only6: md5 = 8bd957e6b35eec50c1439828764da60b OK 2025/01/28 01:21:52 INFO : only6: Copied (replaced existing) 2025/01/28 01:21:52 DEBUG : only7: md5 = 6c63bbe6e3c9c1a801daffe830b39779 OK 2025/01/28 01:21:52 INFO : only7: Copied (replaced existing) 2025/01/28 01:21:52 DEBUG : only3: md5 = afb07b46cbb5961fd04229f5f72a62be OK 2025/01/28 01:21:52 INFO : only3: Copied (replaced existing) 2025/01/28 01:21:52 DEBUG : only9: md5 = aa113945c96f58fc629c0531943558f4 OK 2025/01/28 01:21:52 INFO : only9: Copied (replaced existing) 2025/01/28 01:21:52 DEBUG : only8: md5 = d0d6cf41b1136b5eac682417fec36e3e OK 2025/01/28 01:21:52 INFO : only8: Copied (replaced existing) 2025/01/28 01:21:52 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (22.85s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:22:02 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/01/28 01:22:02 INFO : sub dir: Making directory 2025/01/28 01:22:02 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (3.07s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" 2025/01/28 01:22:05 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/01/28 01:22:05 INFO : sub dir: Making directory 2025/01/28 01:22:05 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo'", Local "Local file system at /tmp/rclone1663140297", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (2.48s) PASS 2025/01/28 01:22:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yexadin9vuwo': Purge remote 2025/01/28 01:22:08 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 5m6.894815254s (try 1/5)