"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2025/04/05 01:17:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo" 2025/04/05 01:17:15 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/05 01:17:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo.bin" 2025/04/05 01:17:16 DEBUG : Swift container crypt path rclone-test-qevofib4raqo.bin: Auto set use_segments_container to true 2025/04/05 01:17:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo" 2025/04/05 01:17:22 DEBUG : Swift container crypt path rclone-test-qevofib4raqo: Auto set use_segments_container to true 2025/04/05 01:17:27 DEBUG : Creating backend with remote "/tmp/rclone3002897795" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.04s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:17:27 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:17:27 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/04/05 01:17:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:17:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.59s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:17:28 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/05 01:17:28 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:17:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:17:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:17:33 DEBUG : sub dir/hello world: md5 = 11e2c897b6643570c54735de9893a73b OK 2025/04/05 01:17:33 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:17:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (16.11s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.20s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.20s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:17:44 DEBUG : Creating backend with remote "/non-existing" 2025/04/05 01:17:44 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/04/05 01:17:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:17:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.50s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:17:50 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:17:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:17:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:17:55 DEBUG : sub dir/hello world: md5 = 0e580171804aa521937c3cfa426c23a3 OK 2025/04/05 01:17:55 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyNoTraverse (15.87s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:18:01 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Running all checks before starting transfers 2025/04/05 01:18:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:18:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:18:01 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Checks finished, now starting transfers 2025/04/05 01:18:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:18:06 DEBUG : sub dir/hello world: md5 = bb4d487b5eda9b7802f394df1d5ccab4 OK 2025/04/05 01:18:06 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyCheckFirst (10.98s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:18:12 ERROR : Ignoring --no-traverse with sync 2025/04/05 01:18:12 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:18:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:18:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:18:17 DEBUG : sub dir/hello world: md5 = f537b63a1bbdd943651b2e68c469014c OK 2025/04/05 01:18:17 INFO : sub dir/hello world: Copied (new) 2025/04/05 01:18:17 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncNoTraverse (10.89s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:18:22 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/04/05 01:18:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:18:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:18:23 DEBUG : hello world2: md5 = 1a2c9f81a7b2c5ee2e389afc707fd636 OK 2025/04/05 01:18:23 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyWithDepth (1.20s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:18:24 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:18:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:18:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:18:29 DEBUG : potato2: md5 = c23931107f730063b70f4bf953e84e7a OK 2025/04/05 01:18:29 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (16.43s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:18:45 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:18:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:18:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:18:50 DEBUG : potato2: md5 = 88ec7c1cf7a5d90e2f6d3d5fcf6b1727 OK 2025/04/05 01:18:50 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (20.98s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:19:01 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/04/05 01:19:01 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/05 01:19:01 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/04/05 01:19:01 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/05 01:19:01 INFO : sub dir: Making directory 2025/04/05 01:19:01 INFO : sub dir2: Making directory 2025/04/05 01:19:01 INFO : sub dir2/sub sub dir2: Making directory 2025/04/05 01:19:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:19:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:19:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:19:06 DEBUG : sub dir/hello world: md5 = 8bf356fdcd902ae59c1528e726d6a750 OK 2025/04/05 01:19:06 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2025/04/05 01:19:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (11.04s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:19:12 INFO : sub dir2: Making directory 2025/04/05 01:19:12 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/04/05 01:19:12 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/05 01:19:12 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:19:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:19:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:19:17 DEBUG : sub dir/hello world: md5 = c961d79605a4930f0faa1e1af4b81aab OK 2025/04/05 01:19:17 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (20.73s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:19:33 DEBUG : sub dir2: Making directory with metadata 2025/04/05 01:19:33 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/05 01:19:33 INFO : sub dir: Making directory 2025/04/05 01:19:33 INFO : sub dir2: Making directory 2025/04/05 01:19:33 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:19:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:19:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:19:38 DEBUG : sub dir/hello world: md5 = d261f68b5a95e48ae36932935a69670a OK 2025/04/05 01:19:38 INFO : sub dir/hello world: Copied (new) 2025/04/05 01:19:38 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/04/05 01:19:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/04/05 01:19:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (11.41s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.09s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:19:44 INFO : sub dir2: Making directory 2025/04/05 01:19:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:19:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:19:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:19:50 DEBUG : sub dir/hello world: md5 = e13c7d5226c05e78815e7e4885f549ca OK 2025/04/05 01:19:50 INFO : sub dir/hello world: Copied (new) 2025/04/05 01:19:50 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (15.88s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:20:00 DEBUG : sub dir2: Making directory with metadata 2025/04/05 01:20:00 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/05 01:20:00 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/05 01:20:00 INFO : sub dir: Making directory 2025/04/05 01:20:00 INFO : sub dir2: Making directory 2025/04/05 01:20:00 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:20:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:20:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:20:05 DEBUG : sub dir/hello world: md5 = 241b0761f30987d910877bf85d4a9a25 OK 2025/04/05 01:20:05 INFO : sub dir/hello world: Copied (new) 2025/04/05 01:20:05 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/04/05 01:20:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (20.95s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.16s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:20:21 INFO : sub dir2: Making directory 2025/04/05 01:20:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:20:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:20:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:20:27 DEBUG : sub dir/hello world: md5 = abb14560520f0cc67bc824c0d89cf4b3 OK 2025/04/05 01:20:27 INFO : sub dir/hello world: Copied (new) 2025/04/05 01:20:27 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (15.64s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:20:42 DEBUG : sub dir/hello world: md5 = 34c8c7edff484e667de488c8c7dc1a59 OK 2025/04/05 01:20:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-secepiv6kele" 2025/04/05 01:20:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-secepiv6kele.bin" 2025/04/05 01:20:43 DEBUG : Swift container crypt path rclone-test-secepiv6kele.bin: Auto set use_segments_container to true 2025/04/05 01:20:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-secepiv6kele" 2025/04/05 01:20:49 DEBUG : Swift container crypt path rclone-test-secepiv6kele: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo' -> Encrypted drive 'TestCryptSwift:rclone-test-secepiv6kele' 2025/04/05 01:20:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:20:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-secepiv6kele': Waiting for checks to finish 2025/04/05 01:20:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-secepiv6kele': Waiting for transfers to finish 2025/04/05 01:21:10 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:21:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-secepiv6kele': Purge remote 2025/04/05 01:21:10 DEBUG : Waiting for deletions to finish 2025/04/05 01:21:15 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (48.95s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:21:31 DEBUG : sub dir/hello world: md5 = daa817006fbb14a1069a3e7798df1884 OK 2025/04/05 01:21:32 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/05 01:21:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:21:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:21:37 DEBUG : sub dir/hello world: md5 = 87f8b05e96a752fc3043e84942f10d53 OK 2025/04/05 01:21:37 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyOverSelf (21.61s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:21:53 DEBUG : sub dir/hello world: md5 = ec8c5546ce0bd69f46cada239d3f6e4f OK 2025/04/05 01:21:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-coqequj2zuja" 2025/04/05 01:21:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-coqequj2zuja.bin" 2025/04/05 01:21:58 DEBUG : Swift container crypt path rclone-test-coqequj2zuja.bin: Auto set use_segments_container to true 2025/04/05 01:22:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-coqequj2zuja" 2025/04/05 01:22:04 DEBUG : Swift container crypt path rclone-test-coqequj2zuja: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo' -> Encrypted drive 'TestCryptSwift:rclone-test-coqequj2zuja' 2025/04/05 01:22:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:22:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-coqequj2zuja': Waiting for checks to finish 2025/04/05 01:22:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-coqequj2zuja': Waiting for transfers to finish 2025/04/05 01:22:21 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:22:31 DEBUG : sub dir/hello world: md5 = 12778e9fdaabed21cf0b8028879171ca OK 2025/04/05 01:22:32 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/05 01:22:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-coqequj2zuja': Waiting for checks to finish 2025/04/05 01:22:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-coqequj2zuja': Waiting for transfers to finish 2025/04/05 01:22:42 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:22:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-coqequj2zuja': Purge remote 2025/04/05 01:22:42 DEBUG : Waiting for deletions to finish 2025/04/05 01:22:52 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (70.87s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:23:04 DEBUG : sub dir/hello world: md5 = ad90257f1207fa309c4db65c142a20e5 OK 2025/04/05 01:23:09 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/05 01:23:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:23:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:23:14 DEBUG : sub dir/hello world: md5 = a8bcad72e7ebbdff803061e7314b7a55 OK 2025/04/05 01:23:14 INFO : sub dir/hello world: Copied (replaced existing) 2025/04/05 01:23:14 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestMoveOverSelf (31.40s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:23:35 DEBUG : sub dir/hello world: md5 = 370fb370c8300bdb209ef1932e70d4c6 OK 2025/04/05 01:23:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-damizif2xanu" 2025/04/05 01:23:35 DEBUG : Config file has changed externally - reloading 2025/04/05 01:23:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-damizif2xanu.bin" 2025/04/05 01:23:36 DEBUG : Swift container crypt path rclone-test-damizif2xanu.bin: Auto set use_segments_container to true 2025/04/05 01:23:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-damizif2xanu" 2025/04/05 01:23:42 DEBUG : Swift container crypt path rclone-test-damizif2xanu: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo' -> Encrypted drive 'TestCryptSwift:rclone-test-damizif2xanu' 2025/04/05 01:23:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:23:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-damizif2xanu': Waiting for checks to finish 2025/04/05 01:23:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-damizif2xanu': Waiting for transfers to finish 2025/04/05 01:23:53 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:23:58 DEBUG : sub dir/hello world: md5 = bcda6d23c77f0ad99968384d80f5aea1 OK 2025/04/05 01:24:03 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/05 01:24:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-damizif2xanu': Waiting for checks to finish 2025/04/05 01:24:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-damizif2xanu': Waiting for transfers to finish 2025/04/05 01:24:09 INFO : sub dir/hello world: Copied (server-side copy) 2025/04/05 01:24:14 INFO : sub dir/hello world: Deleted 2025/04/05 01:24:19 DEBUG : sub dir/hello world: md5 = ae8d12c97aa2fe11d8d0fe681cc37ea5 OK 2025/04/05 01:24:24 DEBUG : testing file moves 2025/04/05 01:24:25 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/04/05 01:24:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-damizif2xanu': Waiting for checks to finish 2025/04/05 01:24:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-damizif2xanu': Waiting for transfers to finish 2025/04/05 01:24:35 INFO : sub dir/hello world: Copied (server-side copy) 2025/04/05 01:24:40 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:24:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-damizif2xanu': Purge remote 2025/04/05 01:24:40 DEBUG : Waiting for deletions to finish 2025/04/05 01:24:40 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (71.08s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:24:46 DEBUG : sub dir/hello world: md5 = 2fea405a99f55258503590a2557934ab OK 2025/04/05 01:24:46 ERROR : : error listing: directory not found 2025/04/05 01:24:46 INFO : Local file system at /tmp/rclone3002897795: Making directory 2025/04/05 01:24:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:24:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyAfterDelete (11.28s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:24:57 DEBUG : sub dir/hello world: md5 = c0cce4869ae29e966adf2b628237981d OK 2025/04/05 01:24:58 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:24:58 DEBUG : Local file system at /tmp/rclone3002897795: Waiting for checks to finish 2025/04/05 01:24:58 DEBUG : Local file system at /tmp/rclone3002897795: Waiting for transfers to finish 2025/04/05 01:24:58 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/05 01:24:58 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyRedownload (11.21s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:03 DEBUG : check sum: Need to transfer - File not found at Destination 2025/04/05 01:25:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:04 DEBUG : check sum: md5 = c72aecd446c930a2a74f7f7f2a2f37d1 OK 2025/04/05 01:25:04 INFO : check sum: Copied (new) 2025/04/05 01:25:04 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:05 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/04/05 01:25:05 DEBUG : check sum: Size of src and dst objects identical 2025/04/05 01:25:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:05 DEBUG : check sum: Unchanged skipping 2025/04/05 01:25:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:05 DEBUG : Waiting for deletions to finish 2025/04/05 01:25:05 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (2.24s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:06 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/04/05 01:25:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:06 DEBUG : sizeonly: md5 = f3607e92b073899550dfbc56b853f70b OK 2025/04/05 01:25:06 INFO : sizeonly: Copied (new) 2025/04/05 01:25:06 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:06 DEBUG : sizeonly: Sizes identical 2025/04/05 01:25:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:06 DEBUG : sizeonly: Unchanged skipping 2025/04/05 01:25:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:06 DEBUG : Waiting for deletions to finish 2025/04/05 01:25:06 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncSizeOnly (1.72s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:07 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/04/05 01:25:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:08 DEBUG : ignore-size: md5 = 3bc8d80ad8b1718a0bfc98c13cd2f7ea OK 2025/04/05 01:25:08 INFO : ignore-size: Copied (new) 2025/04/05 01:25:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:08 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:25:08 DEBUG : ignore-size: Unchanged skipping 2025/04/05 01:25:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:08 DEBUG : Waiting for deletions to finish 2025/04/05 01:25:08 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (2.17s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:15 DEBUG : existing: md5 = 3bd9ec3b8832df87b4f437095ca1993c OK 2025/04/05 01:25:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:15 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:25:15 DEBUG : existing: Unchanged skipping 2025/04/05 01:25:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:15 DEBUG : Waiting for deletions to finish 2025/04/05 01:25:15 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:15 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/04/05 01:25:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:25 DEBUG : existing: md5 = 92aa4212ca95ce6a26cf5e39c89198f2 OK 2025/04/05 01:25:25 INFO : existing: Copied (replaced existing) 2025/04/05 01:25:25 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (21.67s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:31 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/05 01:25:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:36 DEBUG : existing: md5 = 8d73d34cf692775a5c1e6d7e5b22e959 OK 2025/04/05 01:25:36 INFO : existing: Copied (new) 2025/04/05 01:25:36 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:37 DEBUG : existing: Destination exists, skipping 2025/04/05 01:25:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:25:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:25:37 DEBUG : Waiting for deletions to finish 2025/04/05 01:25:37 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (16.43s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:25:53 DEBUG : b/potato: md5 = 41d1cc178f49576ad468234de37dd029 OK 2025/04/05 01:25:59 DEBUG : c/non empty space: md5 = a7f4df1032326d325457e889b7c22d91 OK 2025/04/05 01:25:59 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/04/05 01:25:59 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/05 01:25:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:26:01 DEBUG : a/potato2: md5 = 26cd1a75e1d188652d3db250ba00e219 OK 2025/04/05 01:26:01 INFO : a/potato2: Copied (new) 2025/04/05 01:26:04 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:26:04 DEBUG : c/non empty space: Unchanged skipping 2025/04/05 01:26:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:26:04 DEBUG : Waiting for deletions to finish 2025/04/05 01:26:09 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (32.56s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:26:25 DEBUG : empty space: md5 = 190f3d5a9bcdf96a8b634ed791d23e0c OK 2025/04/05 01:26:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:26:31 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/04/05 01:26:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:26:31 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/04/05 01:26:31 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:26:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:26:31 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/04/05 01:26:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:26:36 DEBUG : empty space: md5 = df0f28701ba0f4a5275a6e2b23c47705 OK 2025/04/05 01:26:36 INFO : empty space: Copied (replaced existing) 2025/04/05 01:26:36 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (26.96s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", 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-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:26:48 DEBUG : foo: md5 = b03042f4735a13b1dea8d4454fb356c0 OK 2025/04/05 01:26:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:26:48 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/04/05 01:26:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:26:48 DEBUG : foo: md5 = 31cbdfb0c5e9c48c54e9b9d6d5020b67 OK 2025/04/05 01:26:48 INFO : foo: Copied (replaced existing) 2025/04/05 01:26:48 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (1.57s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:26:54 DEBUG : empty space: md5 = 076a92c50625d15553971063c1699c48 OK 2025/04/05 01:26:59 DEBUG : potato: Need to transfer - File not found at Destination 2025/04/05 01:26:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:26:59 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:26:59 DEBUG : empty space: Unchanged skipping 2025/04/05 01:26:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:27:00 DEBUG : potato: md5 = 8cac984d130bc2e941fcc4689816d662 OK 2025/04/05 01:27:00 INFO : potato: Copied (new) 2025/04/05 01:27:00 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (17.62s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:27:07 DEBUG : potato: md5 = 806edbe0c3cd2f6bd29af291a4b1de44 OK 2025/04/05 01:27:07 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/04/05 01:27:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:27:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:27:07 DEBUG : potato: md5 = b7ef9d6fe5ddd5d0cc0bb39e5fe3a93d OK 2025/04/05 01:27:07 INFO : potato: Copied (replaced existing) 2025/04/05 01:27:07 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (1.63s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:27:08 DEBUG : potato: md5 = b6fd042954b79003bff3a62a59d436dd OK 2025/04/05 01:27:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:27:09 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/04/05 01:27:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:27:09 DEBUG : potato: md5 = 30ef5751cae263fa62f0514c2d1028db OK 2025/04/05 01:27:09 INFO : potato: Copied (replaced existing) 2025/04/05 01:27:09 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (1.57s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:27:10 DEBUG : potato: md5 = 70ca2942cc5b7f744b8f6151fa6a7cca OK 2025/04/05 01:27:15 DEBUG : empty space: md5 = 14e38f8d3f87fe2755191f2b4b2d8326 OK 2025/04/05 01:27:15 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:27:15 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/04/05 01:27:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:27:20 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:27:20 DEBUG : empty space: Unchanged skipping 2025/04/05 01:27:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:27:20 DEBUG : Waiting for deletions to finish 2025/04/05 01:27:20 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (16.54s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:27:26 DEBUG : potato: md5 = 61170099736c7da14592cce7571728ac OK 2025/04/05 01:27:31 DEBUG : empty space: md5 = 4b7a9f5bc12927278b491b92e614cc88 OK 2025/04/05 01:27:32 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:27:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:27:32 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:27:32 DEBUG : empty space: Unchanged skipping 2025/04/05 01:27:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:27:37 DEBUG : potato2: md5 = d2eaf00329c9f508e7694a67a3165658 OK 2025/04/05 01:27:37 INFO : potato2: Copied (new) 2025/04/05 01:27:37 DEBUG : Waiting for deletions to finish 2025/04/05 01:27:37 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (26.93s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:27:59 DEBUG : b/potato: md5 = 598ac25cf33445eabf404fc26b9ea3c9 OK 2025/04/05 01:28:04 DEBUG : c/non empty space: md5 = 37de7e462ed7f2133402d1ce5e830158 OK 2025/04/05 01:28:04 INFO : d: Making directory 2025/04/05 01:28:04 INFO : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2025/04/05 01:28:09 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/05 01:28:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:28:09 DEBUG : a/potato2: md5 = e651f30c94420308bf369966a43b5a7d OK 2025/04/05 01:28:09 INFO : a/potato2: Copied (new) 2025/04/05 01:28:14 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:28:14 DEBUG : c/non empty space: Unchanged skipping 2025/04/05 01:28:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:28:14 DEBUG : Waiting for deletions to finish 2025/04/05 01:28:19 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (37.00s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:28:36 DEBUG : b/potato: md5 = 638b8132f7aeaace4bdf9c6e83b0220d OK 2025/04/05 01:28:41 DEBUG : c/non empty space: md5 = 2f8f6a7d3d9633302e3e88649d20cf9d OK 2025/04/05 01:28:41 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/04/05 01:28:41 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/05 01:28:41 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:28:41 DEBUG : c/non empty space: Unchanged skipping 2025/04/05 01:28:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:28:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:28:41 DEBUG : a/potato2: md5 = c51f55faa4e8a9f7719e721ef718af26 OK 2025/04/05 01:28:41 INFO : a/potato2: Copied (new) 2025/04/05 01:28:41 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': not deleting files as there were IO errors 2025/04/05 01:28:41 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (32.42s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:29:03 DEBUG : potato: md5 = 36f65dfeab89ce2577f86a903312c83d OK 2025/04/05 01:29:08 DEBUG : empty space: md5 = 6b10123d9b2b41e4d9141a171a933909 OK 2025/04/05 01:29:13 DEBUG : Waiting for deletions to finish 2025/04/05 01:29:13 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:29:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:29:13 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:29:13 DEBUG : empty space: Unchanged skipping 2025/04/05 01:29:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:29:14 INFO : potato: Deleted 2025/04/05 01:29:18 DEBUG : potato2: md5 = b0ebf3d7a0098963d330ab899794203f OK 2025/04/05 01:29:18 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (42.11s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:29:45 DEBUG : potato: md5 = 91df5dfa2ed358a126aede6d201538ee OK 2025/04/05 01:29:50 DEBUG : empty space: md5 = 6ae7039b2456f9d384022e1953b3653e OK 2025/04/05 01:29:50 DEBUG : Waiting for deletions to finish 2025/04/05 01:29:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:29:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:29:51 INFO : potato: Deleted 2025/04/05 01:29:51 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:29:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:29:51 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:29:51 DEBUG : empty space: Unchanged skipping 2025/04/05 01:29:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:29:56 DEBUG : potato2: md5 = 83182c129318affc02d0f630fd16f653 OK 2025/04/05 01:29:56 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (22.53s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:30:07 DEBUG : potato: md5 = 35ce39ec012fe47d76338b84bd3af30c OK 2025/04/05 01:30:08 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:30:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:30:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:30:13 DEBUG : potato2: md5 = 3fdb23853658e67b4a6ab46ea9904f1e OK 2025/04/05 01:30:13 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (11.91s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:30:24 DEBUG : potato2: md5 = 2fb5d4603eb3462e3e579affedd9018a OK 2025/04/05 01:30:29 DEBUG : empty space: md5 = 4bf1940177b7fad62c806bc74d94211b OK 2025/04/05 01:30:35 DEBUG : enormous: Excluded (Size Filter) 2025/04/05 01:30:35 DEBUG : enormous: Excluded 2025/04/05 01:30:35 DEBUG : potato2: Excluded (Size Filter) 2025/04/05 01:30:35 DEBUG : potato2: Excluded 2025/04/05 01:30:35 DEBUG : potato2: Excluded (Size Filter) 2025/04/05 01:30:35 DEBUG : potato2: Excluded 2025/04/05 01:30:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:30:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:30:35 DEBUG : empty space: Unchanged skipping 2025/04/05 01:30:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:30:35 DEBUG : Waiting for deletions to finish 2025/04/05 01:30:35 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:30:40 DEBUG : enormous: Excluded (Size Filter) 2025/04/05 01:30:40 DEBUG : enormous: Excluded 2025/04/05 01:30:40 DEBUG : potato2: Excluded (Size Filter) 2025/04/05 01:30:40 DEBUG : potato2: Excluded 2025/04/05 01:30:40 DEBUG : potato2: Excluded (Size Filter) 2025/04/05 01:30:40 DEBUG : potato2: Excluded 2025/04/05 01:30:40 DEBUG : Local file system at /tmp/rclone3002897795: Waiting for checks to finish 2025/04/05 01:30:40 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:30:40 DEBUG : empty space: Unchanged skipping 2025/04/05 01:30:40 DEBUG : Local file system at /tmp/rclone3002897795: Waiting for transfers to finish 2025/04/05 01:30:40 DEBUG : Waiting for deletions to finish 2025/04/05 01:30:40 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncWithExclude (41.98s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:31:06 DEBUG : potato2: md5 = 316587324d48858260e1a1c7a21708da OK 2025/04/05 01:31:11 DEBUG : empty space: md5 = 4f3c32d67432aeb873c2e45db073d979 OK 2025/04/05 01:31:12 DEBUG : enormous: md5 = a6d06c8155f0204b5e05853c2787665a OK 2025/04/05 01:31:17 DEBUG : enormous: Excluded (Size Filter) 2025/04/05 01:31:17 DEBUG : enormous: Excluded 2025/04/05 01:31:17 DEBUG : potato2: Excluded (Size Filter) 2025/04/05 01:31:17 DEBUG : potato2: Excluded 2025/04/05 01:31:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:31:22 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:31:22 DEBUG : empty space: Unchanged skipping 2025/04/05 01:31:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:31:22 DEBUG : Waiting for deletions to finish 2025/04/05 01:31:22 INFO : enormous: Deleted 2025/04/05 01:31:32 INFO : potato2: Deleted 2025/04/05 01:31:32 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:31:33 DEBUG : Local file system at /tmp/rclone3002897795: Waiting for checks to finish 2025/04/05 01:31:38 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:31:38 DEBUG : empty space: Unchanged skipping 2025/04/05 01:31:38 DEBUG : Local file system at /tmp/rclone3002897795: Waiting for transfers to finish 2025/04/05 01:31:38 DEBUG : Waiting for deletions to finish 2025/04/05 01:31:38 INFO : enormous: Deleted 2025/04/05 01:31:38 INFO : potato2: Deleted 2025/04/05 01:31:38 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (42.53s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:31:49 DEBUG : one: md5 = 94c61fae9e172f9509d3360a8a6efd8d OK 2025/04/05 01:31:49 DEBUG : two: md5 = b5c20e399f3ff0ddbbbee46ab208ad76 OK 2025/04/05 01:31:50 DEBUG : three: md5 = 81331970158e753d7f873b361017f704 OK 2025/04/05 01:31:55 DEBUG : four: md5 = 8c79d1b528d3a09eb4fcb942907f4f9e OK 2025/04/05 01:32:00 DEBUG : five: Need to transfer - File not found at Destination 2025/04/05 01:32:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:32:00 DEBUG : one: Destination is newer than source, skipping 2025/04/05 01:32:01 DEBUG : three: Sizes identical 2025/04/05 01:32:01 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/04/05 01:32:01 DEBUG : two: md5 = 328daa9b7afa98448d0a20fcaff68aa6 OK 2025/04/05 01:32:01 INFO : two: Copied (replaced existing) 2025/04/05 01:32:05 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/04/05 01:32:05 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/04/05 01:32:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:32:06 DEBUG : five: md5 = 94e8adf84d314fc164724440479a72ce OK 2025/04/05 01:32:06 INFO : five: Copied (new) 2025/04/05 01:32:11 DEBUG : four: md5 = eb307f146b65a68274617802855c0d85 OK 2025/04/05 01:32:11 INFO : four: Copied (replaced existing) 2025/04/05 01:32:11 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (63.38s) === 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-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2025/04/05 01:32:47 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Ignoring --track-renames as the source and destination do not have a common hash 2025/04/05 01:32:47 DEBUG : potato: Need to transfer - File not found at Destination 2025/04/05 01:32:47 DEBUG : yam: Need to transfer - File not found at Destination 2025/04/05 01:32:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:32:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:32:47 DEBUG : potato: md5 = ee98e33cefc2f6e909601fbae90ec84a OK 2025/04/05 01:32:47 INFO : potato: Copied (new) 2025/04/05 01:32:53 DEBUG : yam: md5 = a609d9be660d16ae277434da144d59d2 OK 2025/04/05 01:32:53 INFO : yam: Copied (new) 2025/04/05 01:32:53 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:32:58 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Ignoring --track-renames as the source and destination do not have a common hash 2025/04/05 01:32:58 DEBUG : yaml: Need to transfer - File not found at Destination 2025/04/05 01:32:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:32:58 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:32:58 DEBUG : potato: Unchanged skipping 2025/04/05 01:32:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:32:59 DEBUG : yaml: md5 = fa6f49c883bea4ee2fd9c6f8d5b19c3c OK 2025/04/05 01:32:59 INFO : yaml: Copied (new) 2025/04/05 01:32:59 DEBUG : Waiting for deletions to finish 2025/04/05 01:33:09 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (23.15s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2025/04/05 01:33:10 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Making map for --track-renames 2025/04/05 01:33:10 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Finished making map for --track-renames 2025/04/05 01:33:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:33:10 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/05 01:33:10 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/04/05 01:33:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for renames to finish 2025/04/05 01:33:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:33:10 DEBUG : potato: md5 = cee0715b171a151aac6c06bf239013ef OK 2025/04/05 01:33:10 INFO : potato: Copied (new) 2025/04/05 01:33:16 DEBUG : yam: md5 = 249d6ca68040351b84003c6ad1fe837c OK 2025/04/05 01:33:16 INFO : yam: Copied (new) 2025/04/05 01:33:16 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:33:16 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Making map for --track-renames 2025/04/05 01:33:16 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Finished making map for --track-renames 2025/04/05 01:33:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:33:16 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:33:16 DEBUG : potato: Unchanged skipping 2025/04/05 01:33:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for renames to finish 2025/04/05 01:33:27 INFO : yam: Copied (server-side copy) to: yaml 2025/04/05 01:33:32 INFO : yam: Deleted 2025/04/05 01:33:32 INFO : yaml: Renamed from "yam" 2025/04/05 01:33:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:33:32 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (22.91s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2025/04/05 01:33:33 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Making map for --track-renames 2025/04/05 01:33:33 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Finished making map for --track-renames 2025/04/05 01:33:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:33:33 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/05 01:33:33 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/04/05 01:33:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for renames to finish 2025/04/05 01:33:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:33:33 DEBUG : potato: md5 = 0867860a2069485b49603c6a12d9df89 OK 2025/04/05 01:33:33 INFO : potato: Copied (new) 2025/04/05 01:33:38 DEBUG : sub/yam: md5 = 6fe2b7de08a78db4b1e3cf8cae607e42 OK 2025/04/05 01:33:38 INFO : sub/yam: Copied (new) 2025/04/05 01:33:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:33:39 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:33:39 DEBUG : potato: Unchanged skipping 2025/04/05 01:33:39 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Making map for --track-renames 2025/04/05 01:33:39 INFO : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Finished making map for --track-renames 2025/04/05 01:33:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:33:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for renames to finish 2025/04/05 01:33:54 INFO : sub/yam: Copied (server-side copy) to: yam 2025/04/05 01:33:59 INFO : sub/yam: Deleted 2025/04/05 01:33:59 INFO : yam: Renamed from "sub/yam" 2025/04/05 01:33:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:33:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (32.55s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:34:06 DEBUG : Creating backend with remote "/tmp/rclone3002897795/dir1" 2025/04/05 01:34:06 DEBUG : Config file has changed externally - reloading 2025/04/05 01:34:06 DEBUG : Creating backend with remote "/tmp/rclone3002897795/dir2" 2025/04/05 01:34:06 DEBUG : Local file system at /tmp/rclone3002897795/dir2: Using server-side directory move 2025/04/05 01:34:06 INFO : Local file system at /tmp/rclone3002897795/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/05 01:34:06 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/04/05 01:34:06 INFO : file1.txt: Moved (server-side) 2025/04/05 01:34:06 DEBUG : Local file system at /tmp/rclone3002897795/dir2: Waiting for checks to finish 2025/04/05 01:34:06 DEBUG : Local file system at /tmp/rclone3002897795/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.12s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:34:06 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:34:06 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/04/05 01:34:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:34:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:34:11 DEBUG : sub dir/hello world: md5 = b31eda1ddab95cedac998c5590925ace OK 2025/04/05 01:34:11 INFO : sub dir/hello world: Copied (new) 2025/04/05 01:34:11 INFO : sub dir/hello world: Deleted 2025/04/05 01:34:11 DEBUG : nested/sub dir/file: md5 = 5befa6f05053e592618b34aeac83623f OK 2025/04/05 01:34:11 INFO : nested/sub dir/file: Copied (new) 2025/04/05 01:34:11 INFO : nested/sub dir/file: Deleted 2025/04/05 01:34:11 INFO : sub dir: Removing directory 2025/04/05 01:34:11 INFO : nested/sub dir: Removing directory 2025/04/05 01:34:11 INFO : nested: Removing directory 2025/04/05 01:34:11 DEBUG : Local file system at /tmp/rclone3002897795: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (16.38s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:34:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/05 01:34:22 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/04/05 01:34:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:34:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:34:27 DEBUG : nested/sub dir/file: md5 = a00c6820d52565f8b9c22021616f8848 OK 2025/04/05 01:34:27 INFO : nested/sub dir/file: Copied (new) 2025/04/05 01:34:27 INFO : nested/sub dir/file: Deleted 2025/04/05 01:34:27 DEBUG : sub dir/hello world: md5 = 99cc04d5305a1f4b94ee9d9b9394de34 OK 2025/04/05 01:34:27 INFO : sub dir/hello world: Copied (new) 2025/04/05 01:34:27 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (26.10s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:34:48 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/05 01:34:48 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/04/05 01:34:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:34:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:34:53 DEBUG : existing: md5 = 0ee1866b53cc0f019363111d9df1d1bc OK 2025/04/05 01:34:53 INFO : existing: Copied (new) 2025/04/05 01:34:53 INFO : existing: Deleted 2025/04/05 01:34:54 DEBUG : existing-b: md5 = d338325f13f49e4dcf89c8157a5a8aef OK 2025/04/05 01:34:54 INFO : existing-b: Copied (new) 2025/04/05 01:34:54 INFO : existing-b: Deleted 2025/04/05 01:35:04 DEBUG : existing: Destination exists, skipping 2025/04/05 01:35:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:35:09 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/04/05 01:35:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:35:09 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (41.69s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:35:30 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yahecen1naca" 2025/04/05 01:35:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yahecen1naca.bin" 2025/04/05 01:35:30 DEBUG : Swift container crypt path rclone-test-yahecen1naca.bin: Auto set use_segments_container to true 2025/04/05 01:35:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yahecen1naca" 2025/04/05 01:35:36 DEBUG : Swift container crypt path rclone-test-yahecen1naca: Auto set use_segments_container to true 2025/04/05 01:35:47 DEBUG : potato2: md5 = 7fba71d1d68ae66b64b0c4ac3c9ce8c5 OK 2025/04/05 01:35:53 DEBUG : empty space: md5 = e34d560bf567d37f855b286507133051 OK 2025/04/05 01:35:58 DEBUG : potato3: md5 = 931e96ac640d95e5001fb9b199b6666c OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo' -> Encrypted drive 'TestCryptSwift:rclone-test-yahecen1naca' 2025/04/05 01:36:09 DEBUG : empty space: md5 = 62abe674fbadba5f0350ebe336dd6f8e OK 2025/04/05 01:36:14 DEBUG : potato3: md5 = 441e374c90c20477416c0295c35ff141 OK 2025/04/05 01:36:19 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:36:19 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/05 01:36:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yahecen1naca': Waiting for checks to finish 2025/04/05 01:36:24 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:36:24 DEBUG : empty space: Unchanged skipping 2025/04/05 01:36:30 INFO : empty space: Deleted 2025/04/05 01:36:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yahecen1naca': Waiting for transfers to finish 2025/04/05 01:36:35 INFO : potato3: Copied (server-side copy) 2025/04/05 01:36:35 INFO : potato2: Copied (server-side copy) 2025/04/05 01:36:40 INFO : potato3: Deleted 2025/04/05 01:36:40 INFO : potato2: Deleted 2025/04/05 01:36:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-vucedaq9cixa" 2025/04/05 01:36:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-vucedaq9cixa.bin" 2025/04/05 01:36:46 DEBUG : Swift container crypt path rclone-test-vucedaq9cixa.bin: Auto set use_segments_container to true 2025/04/05 01:36:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-vucedaq9cixa" 2025/04/05 01:36:52 DEBUG : Swift container crypt path rclone-test-vucedaq9cixa: Auto set use_segments_container to true 2025/04/05 01:36:57 DEBUG : empty space: Need to transfer - File not found at Destination 2025/04/05 01:36:57 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:36:57 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/05 01:36:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vucedaq9cixa': Waiting for checks to finish 2025/04/05 01:36:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vucedaq9cixa': Waiting for transfers to finish 2025/04/05 01:37:04 INFO : potato3: Copied (server-side copy) 2025/04/05 01:37:09 INFO : potato3: Deleted 2025/04/05 01:37:13 INFO : empty space: Copied (server-side copy) 2025/04/05 01:37:13 INFO : potato2: Copied (server-side copy) 2025/04/05 01:37:18 INFO : empty space: Deleted 2025/04/05 01:37:18 INFO : potato2: Deleted 2025/04/05 01:37:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vucedaq9cixa': Purge remote 2025/04/05 01:37:28 DEBUG : Waiting for deletions to finish 2025/04/05 01:37:29 INFO : potato3.bin: Deleted 2025/04/05 01:37:39 INFO : potato2.bin: Deleted 2025/04/05 01:37:39 INFO : empty space.bin: Deleted 2025/04/05 01:37:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yahecen1naca': Purge remote 2025/04/05 01:37:39 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (128.99s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:37:39 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-nodamon6tope" 2025/04/05 01:37:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nodamon6tope.bin" 2025/04/05 01:37:39 DEBUG : Swift container crypt path rclone-test-nodamon6tope.bin: Auto set use_segments_container to true 2025/04/05 01:37:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nodamon6tope" 2025/04/05 01:37:45 DEBUG : Swift container crypt path rclone-test-nodamon6tope: Auto set use_segments_container to true 2025/04/05 01:37:56 DEBUG : potato2: md5 = 679cb53fbd6ae87beda18464ecf581b6 OK 2025/04/05 01:38:01 DEBUG : empty space: md5 = 68197e81506f486b5609f1d12d612e97 OK 2025/04/05 01:38:06 DEBUG : potato3: md5 = 4e9d3f266eea87424b2af016f94938da OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo' -> Encrypted drive 'TestCryptSwift:rclone-test-nodamon6tope' 2025/04/05 01:38:12 DEBUG : empty space: md5 = 2bce6747b42c3b653d65c63afa6476a1 OK 2025/04/05 01:38:12 DEBUG : potato3: md5 = aba1f27ae09a0643fb3413d8780b4012 OK 2025/04/05 01:38:13 DEBUG : empty space: Excluded (Size Filter) 2025/04/05 01:38:13 DEBUG : empty space: Excluded 2025/04/05 01:38:13 DEBUG : empty space: Excluded (Size Filter) 2025/04/05 01:38:13 DEBUG : empty space: Excluded 2025/04/05 01:38:13 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:38:13 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/05 01:38:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nodamon6tope': Waiting for checks to finish 2025/04/05 01:38:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nodamon6tope': Waiting for transfers to finish 2025/04/05 01:38:23 INFO : potato3: Copied (server-side copy) 2025/04/05 01:38:28 INFO : potato2: Copied (server-side copy) 2025/04/05 01:38:28 INFO : potato3: Deleted 2025/04/05 01:38:33 INFO : potato2: Deleted 2025/04/05 01:38:39 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-sopakag9doge" 2025/04/05 01:38:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sopakag9doge.bin" 2025/04/05 01:38:39 DEBUG : Swift container crypt path rclone-test-sopakag9doge.bin: Auto set use_segments_container to true 2025/04/05 01:38:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sopakag9doge" 2025/04/05 01:38:45 DEBUG : Swift container crypt path rclone-test-sopakag9doge: Auto set use_segments_container to true 2025/04/05 01:38:55 DEBUG : empty space: Excluded (Size Filter) 2025/04/05 01:38:55 DEBUG : empty space: Excluded 2025/04/05 01:38:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:38:56 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/05 01:38:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sopakag9doge': Waiting for checks to finish 2025/04/05 01:38:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sopakag9doge': Waiting for transfers to finish 2025/04/05 01:39:11 INFO : potato2: Copied (server-side copy) 2025/04/05 01:39:11 INFO : potato3: Copied (server-side copy) 2025/04/05 01:39:11 INFO : potato3: Deleted 2025/04/05 01:39:16 INFO : potato2: Deleted 2025/04/05 01:39:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sopakag9doge': Purge remote 2025/04/05 01:39:16 DEBUG : Waiting for deletions to finish 2025/04/05 01:39:22 INFO : potato2.bin: Deleted 2025/04/05 01:39:22 INFO : potato3.bin: Deleted 2025/04/05 01:39:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nodamon6tope': Purge remote 2025/04/05 01:39:22 DEBUG : Waiting for deletions to finish 2025/04/05 01:39:22 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (108.47s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:39:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qutakut1tike" 2025/04/05 01:39:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qutakut1tike.bin" 2025/04/05 01:39:28 DEBUG : Swift container crypt path rclone-test-qutakut1tike.bin: Auto set use_segments_container to true 2025/04/05 01:39:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qutakut1tike" 2025/04/05 01:39:34 DEBUG : Swift container crypt path rclone-test-qutakut1tike: Auto set use_segments_container to true 2025/04/05 01:39:50 DEBUG : potato2: md5 = 25c572ba4811d3f6b248ffd7d532a5cf OK 2025/04/05 01:39:55 DEBUG : empty space: md5 = 6f263df40d586477c373ef97dab1de8c OK 2025/04/05 01:40:00 DEBUG : potato3: md5 = 839bfce5bab6b9ca4dfcbbf91a463271 OK 2025/04/05 01:40:00 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo' -> Encrypted drive 'TestCryptSwift:rclone-test-qutakut1tike' 2025/04/05 01:40:01 DEBUG : empty space: md5 = 531cf5de38112b1433950981945f087b OK 2025/04/05 01:40:01 DEBUG : potato3: md5 = 9f0f14029c61425e60d23071ff48b4da OK 2025/04/05 01:40:02 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:40:02 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/05 01:40:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qutakut1tike': Waiting for checks to finish 2025/04/05 01:40:02 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:40:02 DEBUG : empty space: Unchanged skipping 2025/04/05 01:40:07 INFO : potato3: Copied (server-side copy) 2025/04/05 01:40:07 INFO : empty space: Deleted 2025/04/05 01:40:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qutakut1tike': Waiting for transfers to finish 2025/04/05 01:40:12 INFO : potato2: Copied (server-side copy) 2025/04/05 01:40:12 INFO : potato3: Deleted 2025/04/05 01:40:17 INFO : potato2: Deleted 2025/04/05 01:40:18 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yumotih7katu" 2025/04/05 01:40:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yumotih7katu.bin" 2025/04/05 01:40:18 DEBUG : Swift container crypt path rclone-test-yumotih7katu.bin: Auto set use_segments_container to true 2025/04/05 01:40:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yumotih7katu" 2025/04/05 01:40:24 DEBUG : Swift container crypt path rclone-test-yumotih7katu: Auto set use_segments_container to true 2025/04/05 01:40:29 INFO : tomatoDir: Making directory 2025/04/05 01:40:30 DEBUG : empty space: Need to transfer - File not found at Destination 2025/04/05 01:40:30 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/05 01:40:30 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/05 01:40:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yumotih7katu': Waiting for checks to finish 2025/04/05 01:40:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yumotih7katu': Waiting for transfers to finish 2025/04/05 01:40:40 INFO : potato3: Copied (server-side copy) 2025/04/05 01:40:41 INFO : potato3: Deleted 2025/04/05 01:40:45 INFO : potato2: Copied (server-side copy) 2025/04/05 01:40:45 INFO : empty space: Copied (server-side copy) 2025/04/05 01:40:45 INFO : potato2: Deleted 2025/04/05 01:40:45 INFO : empty space: Deleted 2025/04/05 01:40:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yumotih7katu': Purge remote 2025/04/05 01:40:46 DEBUG : Waiting for deletions to finish 2025/04/05 01:40:51 INFO : empty space.bin: Deleted 2025/04/05 01:40:51 INFO : potato3.bin: Deleted 2025/04/05 01:40:51 INFO : potato2.bin: Deleted 2025/04/05 01:40:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qutakut1tike': Purge remote 2025/04/05 01:40:51 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (84.18s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:40:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/rclone-move-test" 2025/04/05 01:40:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-move-test.bin" 2025/04/05 01:40:52 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-move-test.bin: Auto set use_segments_container to true 2025/04/05 01:40:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-move-test" 2025/04/05 01:40:58 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-move-test: Auto set use_segments_container to true 2025/04/05 01:41:09 DEBUG : potato2: md5 = f97d4a72db9cc28102dce4a584e8eaa6 OK --- PASS: TestServerSideMoveOverlap (32.77s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:41:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test" 2025/04/05 01:41:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-sync-test.bin" 2025/04/05 01:41:25 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-sync-test.bin: Auto set use_segments_container to true 2025/04/05 01:41:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-sync-test" 2025/04/05 01:41:31 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncOverlap (12.67s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:41:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test" 2025/04/05 01:41:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-sync-test.bin" 2025/04/05 01:41:38 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-sync-test.bin: Auto set use_segments_container to true 2025/04/05 01:41:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-sync-test" 2025/04/05 01:41:43 DEBUG : Config file has changed externally - reloading 2025/04/05 01:41:43 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-sync-test: Auto set use_segments_container to true 2025/04/05 01:41:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test-include/layer2" 2025/04/05 01:41:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-sync-test-include/layer2.bin" 2025/04/05 01:41:49 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/04/05 01:41:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-sync-test-include/layer2" 2025/04/05 01:41:55 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/04/05 01:42:00 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test-ignore-file" 2025/04/05 01:42:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-sync-test-ignore-file.bin" 2025/04/05 01:42:01 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/04/05 01:42:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/rclone-sync-test-ignore-file" 2025/04/05 01:42:07 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/04/05 01:42:17 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = 59483b794c0b6925458e10a3e4951c80 OK 2025/04/05 01:42:23 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/05 01:42:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test': Waiting for checks to finish 2025/04/05 01:42:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test': Waiting for transfers to finish 2025/04/05 01:42:23 DEBUG : Waiting for deletions to finish 2025/04/05 01:42:23 INFO : There was nothing to transfer 2025/04/05 01:42:28 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/05 01:42:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:42:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:42:28 DEBUG : Waiting for deletions to finish 2025/04/05 01:42:28 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:42:38 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/05 01:42:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/04/05 01:42:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/04/05 01:42:38 DEBUG : Waiting for deletions to finish 2025/04/05 01:42:38 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:42:43 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/05 01:42:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:42:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:42:43 DEBUG : Waiting for deletions to finish 2025/04/05 01:42:43 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:42:44 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/05 01:42:44 DEBUG : : Excluded 2025/04/05 01:42:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/04/05 01:42:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/04/05 01:42:44 DEBUG : Waiting for deletions to finish 2025/04/05 01:42:44 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (75.43s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:42:52 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/dst" 2025/04/05 01:42:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst.bin" 2025/04/05 01:42:53 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst.bin: Auto set use_segments_container to true 2025/04/05 01:42:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst" 2025/04/05 01:42:59 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst: Auto set use_segments_container to true 2025/04/05 01:43:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/CompareDest" 2025/04/05 01:43:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/CompareDest.bin" 2025/04/05 01:43:05 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/CompareDest.bin: Auto set use_segments_container to true 2025/04/05 01:43:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/CompareDest" 2025/04/05 01:43:11 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/CompareDest: Auto set use_segments_container to true 2025/04/05 01:43:21 DEBUG : one: Need to transfer - File not found at Destination 2025/04/05 01:43:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:43:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:43:22 DEBUG : one: md5 = d7c2e44667c6be92813b45ebc443c182 OK 2025/04/05 01:43:22 INFO : one: Copied (new) 2025/04/05 01:43:22 DEBUG : Waiting for deletions to finish 2025/04/05 01:43:22 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/05 01:43:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:43:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:43:28 DEBUG : one: md5 = 463e7aa750e8ed5094a8a15bf4695fda OK 2025/04/05 01:43:28 INFO : one: Copied (replaced existing) 2025/04/05 01:43:28 DEBUG : Waiting for deletions to finish 2025/04/05 01:43:28 DEBUG : dst/one: md5 = 1ce687e4c552696ac834adc49c9cdae6 OK 2025/04/05 01:43:33 DEBUG : CompareDest/one: md5 = e87c649a668ec7f738805a3d230adb80 OK 2025/04/05 01:43:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:43:39 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/05 01:43:39 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:43:39 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/05 01:43:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:43:39 DEBUG : Waiting for deletions to finish 2025/04/05 01:43:39 INFO : There was nothing to transfer 2025/04/05 01:43:44 DEBUG : CompareDest/two: md5 = 97942509674d2e3831f4ba3d19ce20f6 OK 2025/04/05 01:43:50 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:43:50 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/05 01:43:50 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/05 01:43:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:43:55 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:43:55 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/05 01:43:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:43:55 DEBUG : Waiting for deletions to finish 2025/04/05 01:43:55 INFO : There was nothing to transfer 2025/04/05 01:44:05 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:44:05 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/05 01:44:05 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/05 01:44:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:44:10 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:44:10 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/05 01:44:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:44:10 DEBUG : Waiting for deletions to finish 2025/04/05 01:44:10 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2025/04/05 01:44:20 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/04/05 01:44:20 DEBUG : two: Need to transfer - File not found at Destination 2025/04/05 01:44:20 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/05 01:44:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:44:20 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:44:20 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/05 01:44:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:44:21 DEBUG : two: md5 = 89fec1d48d75fb6aec557044ac84a722 OK 2025/04/05 01:44:21 INFO : two: Copied (new) 2025/04/05 01:44:21 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (100.05s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:44:33 DEBUG : pre-dest1/1: md5 = 80500438f800ab216d3e278eb0fb02ae OK 2025/04/05 01:44:38 DEBUG : pre-dest2/2: md5 = eb56749ffaf6b66ec0dcb745e9905313 OK 2025/04/05 01:44:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/dest" 2025/04/05 01:44:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dest.bin" 2025/04/05 01:44:44 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dest.bin: Auto set use_segments_container to true 2025/04/05 01:44:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dest" 2025/04/05 01:44:50 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dest: Auto set use_segments_container to true 2025/04/05 01:44:55 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/pre-dest1" 2025/04/05 01:44:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/pre-dest1.bin" 2025/04/05 01:44:56 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/pre-dest1.bin: Auto set use_segments_container to true 2025/04/05 01:45:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/pre-dest1" 2025/04/05 01:45:02 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/pre-dest1: Auto set use_segments_container to true 2025/04/05 01:45:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/pre-dest2" 2025/04/05 01:45:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/pre-dest2.bin" 2025/04/05 01:45:07 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/pre-dest2.bin: Auto set use_segments_container to true 2025/04/05 01:45:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/pre-dest2" 2025/04/05 01:45:14 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/pre-dest2: Auto set use_segments_container to true 2025/04/05 01:45:19 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:45:19 DEBUG : 1: Destination found in --compare-dest, skipping 2025/04/05 01:45:24 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:45:24 DEBUG : 2: Destination found in --compare-dest, skipping 2025/04/05 01:45:35 DEBUG : 3: Need to transfer - File not found at Destination 2025/04/05 01:45:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dest': Waiting for checks to finish 2025/04/05 01:45:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dest': Waiting for transfers to finish 2025/04/05 01:45:35 DEBUG : 3: md5 = 39baa0e930f4f75d5a4d36dc59a13459 OK 2025/04/05 01:45:35 INFO : 3: Copied (new) 2025/04/05 01:45:35 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (68.74s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:45:41 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/dst" 2025/04/05 01:45:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst.bin" 2025/04/05 01:45:42 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst.bin: Auto set use_segments_container to true 2025/04/05 01:45:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst" 2025/04/05 01:45:47 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst: Auto set use_segments_container to true 2025/04/05 01:45:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/CopyDest" 2025/04/05 01:45:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/CopyDest.bin" 2025/04/05 01:45:53 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/CopyDest.bin: Auto set use_segments_container to true 2025/04/05 01:45:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/CopyDest" 2025/04/05 01:45:59 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/CopyDest: Auto set use_segments_container to true 2025/04/05 01:46:10 DEBUG : one: Need to transfer - File not found at Destination 2025/04/05 01:46:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:46:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:46:10 DEBUG : one: md5 = 93eea0f50d4de24d59a6e4ee785dd41f OK 2025/04/05 01:46:10 INFO : one: Copied (new) 2025/04/05 01:46:10 DEBUG : Waiting for deletions to finish 2025/04/05 01:46:10 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/05 01:46:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:46:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:46:15 DEBUG : one: md5 = ad0e0e4ea1cbdf19ea43aa086a773650 OK 2025/04/05 01:46:15 INFO : one: Copied (replaced existing) 2025/04/05 01:46:15 DEBUG : Waiting for deletions to finish 2025/04/05 01:46:16 DEBUG : dst/one: md5 = 6728d16ea5a77e4a2675f87231d2c900 OK 2025/04/05 01:46:21 DEBUG : CopyDest/one: md5 = a6ff8a0fc78e98b1d08faaeda56635d1 OK 2025/04/05 01:46:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/BackupDir" 2025/04/05 01:46:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/BackupDir.bin" 2025/04/05 01:46:22 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/BackupDir.bin: Auto set use_segments_container to true 2025/04/05 01:46:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/BackupDir" 2025/04/05 01:46:28 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/BackupDir: Auto set use_segments_container to true 2025/04/05 01:46:33 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/05 01:46:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:46:34 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:46:34 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/05 01:46:44 INFO : one: Copied (server-side copy) 2025/04/05 01:46:44 INFO : one: Deleted 2025/04/05 01:46:50 INFO : one: Copied (server-side copy) 2025/04/05 01:46:50 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/04/05 01:46:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:46:50 DEBUG : Waiting for deletions to finish 2025/04/05 01:46:55 DEBUG : CopyDest/two: md5 = c2438956c8cace802913f96e153ca3c0 OK 2025/04/05 01:47:01 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:47:06 INFO : two: Copied (server-side copy) 2025/04/05 01:47:06 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/04/05 01:47:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:47:06 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:47:06 DEBUG : one: Unchanged skipping 2025/04/05 01:47:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:47:06 DEBUG : Waiting for deletions to finish 2025/04/05 01:47:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:47:06 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:47:06 DEBUG : one: Unchanged skipping 2025/04/05 01:47:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:47:07 DEBUG : two: Unchanged skipping 2025/04/05 01:47:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:47:07 DEBUG : Waiting for deletions to finish 2025/04/05 01:47:07 INFO : There was nothing to transfer 2025/04/05 01:47:07 DEBUG : CopyDest/three: md5 = 97517dd4ad6482ced00bb03cd821afb3 OK 2025/04/05 01:47:13 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/04/05 01:47:13 DEBUG : three: Destination not found in --copy-dest 2025/04/05 01:47:13 DEBUG : three: Need to transfer - File not found at Destination 2025/04/05 01:47:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:47:13 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:47:13 DEBUG : one: Unchanged skipping 2025/04/05 01:47:13 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:47:13 DEBUG : two: Unchanged skipping 2025/04/05 01:47:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:47:18 DEBUG : three: md5 = d0305e2b44c6cbd1d45f3db6ac2f190d OK 2025/04/05 01:47:18 INFO : three: Copied (new) 2025/04/05 01:47:18 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (118.77s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:47:40 DEBUG : dst/one: md5 = 0540e2fb5c7352a83fadf695d0e000da OK 2025/04/05 01:47:40 DEBUG : dst/two: md5 = 42018de1ce6e5374a492826a259edc2e OK 2025/04/05 01:47:46 DEBUG : dst/three.txt: md5 = 7051596251da77ff1cd012e6c3d4aa33 OK 2025/04/05 01:47:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/dst" 2025/04/05 01:47:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst.bin" 2025/04/05 01:47:51 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst.bin: Auto set use_segments_container to true 2025/04/05 01:47:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst" 2025/04/05 01:47:57 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst: Auto set use_segments_container to true 2025/04/05 01:48:03 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/backup" 2025/04/05 01:48:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/backup.bin" 2025/04/05 01:48:03 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/backup.bin: Auto set use_segments_container to true 2025/04/05 01:48:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/backup" 2025/04/05 01:48:09 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/backup: Auto set use_segments_container to true 2025/04/05 01:48:15 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/05 01:48:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:48:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:48:15 DEBUG : two: Unchanged skipping 2025/04/05 01:48:41 INFO : one: Copied (server-side copy) 2025/04/05 01:48:41 INFO : one: Deleted 2025/04/05 01:48:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:48:41 DEBUG : one: md5 = 38ba95eef7855e67402efcdaecc855ed OK 2025/04/05 01:48:41 INFO : one: Copied (new) 2025/04/05 01:48:41 DEBUG : Waiting for deletions to finish 2025/04/05 01:48:52 INFO : three.txt: Copied (server-side copy) 2025/04/05 01:48:57 INFO : three.txt: Deleted 2025/04/05 01:48:57 INFO : three.txt: Moved into backup dir 2025/04/05 01:49:03 DEBUG : dst/three.txt: md5 = 214a20718ac045c6ef4b1401fd1020b1 OK 2025/04/05 01:49:08 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/05 01:49:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:49:08 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:49:08 DEBUG : two: Unchanged skipping 2025/04/05 01:49:24 INFO : one: Copied (server-side copy) 2025/04/05 01:49:24 INFO : one: Deleted 2025/04/05 01:49:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:49:24 DEBUG : one: md5 = 63b18ef61ccb50dbe8f6a63e57172ecd OK 2025/04/05 01:49:24 INFO : one: Copied (new) 2025/04/05 01:49:24 DEBUG : Waiting for deletions to finish 2025/04/05 01:49:35 INFO : three.txt: Copied (server-side copy) 2025/04/05 01:49:40 INFO : three.txt: Deleted 2025/04/05 01:49:40 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (130.98s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:49:51 DEBUG : dst/one: md5 = 804381b0c77f9ac6644e2b5c87b031d2 OK 2025/04/05 01:49:51 DEBUG : dst/two: md5 = 0f1370d402d735f6dc043a22ae7364a1 OK 2025/04/05 01:49:56 DEBUG : dst/three.txt: md5 = 271bc8b5355511463b0f287b3ccb4914 OK 2025/04/05 01:49:57 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/dst" 2025/04/05 01:49:57 DEBUG : Config file has changed externally - reloading 2025/04/05 01:49:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst.bin" 2025/04/05 01:49:57 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst.bin: Auto set use_segments_container to true 2025/04/05 01:50:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst" 2025/04/05 01:50:03 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst: Auto set use_segments_container to true 2025/04/05 01:50:08 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/backup" 2025/04/05 01:50:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/backup.bin" 2025/04/05 01:50:09 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/backup.bin: Auto set use_segments_container to true 2025/04/05 01:50:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/backup" 2025/04/05 01:50:14 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/backup: Auto set use_segments_container to true 2025/04/05 01:50:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/05 01:50:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:50:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:50:20 DEBUG : two: Unchanged skipping 2025/04/05 01:50:31 INFO : one: Copied (server-side copy) to: one.bak 2025/04/05 01:50:31 INFO : one: Deleted 2025/04/05 01:50:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:50:31 DEBUG : one: md5 = 4ac52f0a3caa9bf6451be254fa702adb OK 2025/04/05 01:50:31 INFO : one: Copied (new) 2025/04/05 01:50:31 DEBUG : Waiting for deletions to finish 2025/04/05 01:50:47 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/05 01:50:52 INFO : three.txt: Deleted 2025/04/05 01:50:52 INFO : three.txt: Moved into backup dir 2025/04/05 01:50:57 DEBUG : dst/three.txt: md5 = f37897b34c4852bc48667ce394c42a8e OK 2025/04/05 01:50:58 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/05 01:50:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:50:58 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:50:58 DEBUG : two: Unchanged skipping 2025/04/05 01:51:03 INFO : one: Copied (server-side copy) to: one.bak 2025/04/05 01:51:03 INFO : one: Deleted 2025/04/05 01:51:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:51:03 DEBUG : one: md5 = e33f33ddb1fd61c2f05e1d681b1dca72 OK 2025/04/05 01:51:03 INFO : one: Copied (new) 2025/04/05 01:51:03 DEBUG : Waiting for deletions to finish 2025/04/05 01:51:14 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/05 01:51:19 INFO : three.txt: Deleted 2025/04/05 01:51:19 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (89.19s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:51:20 DEBUG : dst/one: md5 = cf1af38f8b0579b957ef4a2ef515662d OK 2025/04/05 01:51:20 DEBUG : dst/two: md5 = c752730f6f5b13831fe2164e3d5d3439 OK 2025/04/05 01:51:26 DEBUG : dst/three.txt: md5 = 33ee1f99e5155cf16181ee0607ab205d OK 2025/04/05 01:51:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/dst" 2025/04/05 01:51:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst.bin" 2025/04/05 01:51:26 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst.bin: Auto set use_segments_container to true 2025/04/05 01:51:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst" 2025/04/05 01:51:32 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst: Auto set use_segments_container to true 2025/04/05 01:51:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/backup" 2025/04/05 01:51:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/backup.bin" 2025/04/05 01:51:38 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/backup.bin: Auto set use_segments_container to true 2025/04/05 01:51:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/backup" 2025/04/05 01:51:44 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/backup: Auto set use_segments_container to true 2025/04/05 01:51:50 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/05 01:51:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:51:50 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:51:50 DEBUG : two: Unchanged skipping 2025/04/05 01:52:05 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/05 01:52:06 INFO : one: Deleted 2025/04/05 01:52:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:52:06 DEBUG : one: md5 = e8e63ccd91a18d5ac58c763c35948117 OK 2025/04/05 01:52:06 INFO : one: Copied (new) 2025/04/05 01:52:06 DEBUG : Waiting for deletions to finish 2025/04/05 01:52:22 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/05 01:52:28 INFO : three.txt: Deleted 2025/04/05 01:52:28 INFO : three.txt: Moved into backup dir 2025/04/05 01:52:38 DEBUG : dst/three.txt: md5 = c8e77e6578f2f0d076b09bec9990113d OK 2025/04/05 01:52:48 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/05 01:52:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:52:49 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:52:49 DEBUG : two: Unchanged skipping 2025/04/05 01:52:59 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/05 01:52:59 INFO : one: Deleted 2025/04/05 01:52:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:52:59 DEBUG : one: md5 = b3a4e24ccd9b08aa57a109bf99480b40 OK 2025/04/05 01:52:59 INFO : one: Copied (new) 2025/04/05 01:52:59 DEBUG : Waiting for deletions to finish 2025/04/05 01:53:10 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/05 01:53:15 INFO : three.txt: Deleted 2025/04/05 01:53:15 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (131.32s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:53:32 DEBUG : dst/one: md5 = 9ba85b5a728ef76e92c158724932efdb OK 2025/04/05 01:53:32 DEBUG : dst/two: md5 = c50c957a00dffa2b49da808dd4637f03 OK 2025/04/05 01:53:37 DEBUG : dst/three.txt: md5 = 3e4c7b0c4a3078b7ca41b7852e7ff3f2 OK 2025/04/05 01:53:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/dst" 2025/04/05 01:53:43 DEBUG : Config file has changed externally - reloading 2025/04/05 01:53:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst.bin" 2025/04/05 01:53:43 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst.bin: Auto set use_segments_container to true 2025/04/05 01:53:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst" 2025/04/05 01:53:49 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst: Auto set use_segments_container to true 2025/04/05 01:53:54 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/05 01:53:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:53:55 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:53:55 DEBUG : two: Unchanged skipping 2025/04/05 01:54:10 INFO : one: Copied (server-side copy) to: one.bak 2025/04/05 01:54:10 INFO : one: Deleted 2025/04/05 01:54:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:54:10 DEBUG : one: md5 = 7c4f012a478be50dc788f5d8fe850d92 OK 2025/04/05 01:54:10 INFO : one: Copied (new) 2025/04/05 01:54:10 DEBUG : Waiting for deletions to finish 2025/04/05 01:54:26 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/05 01:54:31 INFO : three.txt: Deleted 2025/04/05 01:54:31 INFO : three.txt: Moved into backup dir 2025/04/05 01:54:37 DEBUG : dst/three.txt: md5 = dfabcb363a2350f5b041cbd2fe8b5290 OK 2025/04/05 01:54:42 DEBUG : one.bak: Excluded (Path Filter) 2025/04/05 01:54:42 DEBUG : one.bak: Excluded 2025/04/05 01:54:42 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/04/05 01:54:42 DEBUG : three.txt.bak: Excluded 2025/04/05 01:54:42 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/05 01:54:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for checks to finish 2025/04/05 01:54:42 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:54:42 DEBUG : two: Unchanged skipping 2025/04/05 01:54:58 INFO : one: Copied (server-side copy) to: one.bak 2025/04/05 01:54:58 INFO : one: Deleted 2025/04/05 01:54:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo/dst': Waiting for transfers to finish 2025/04/05 01:54:58 DEBUG : one: md5 = a3ec7489a816ebb2de511555e0c83545 OK 2025/04/05 01:54:58 INFO : one: Copied (new) 2025/04/05 01:54:58 DEBUG : Waiting for deletions to finish 2025/04/05 01:55:03 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/05 01:55:08 INFO : three.txt: Deleted 2025/04/05 01:55:08 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (108.23s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:55:20 DEBUG : dst/one: md5 = 3509b13c2a2cbe060b9b3c6533ea207d OK 2025/04/05 01:55:20 DEBUG : dst/two: md5 = 9bbffd34daabf77754eaf4a889f8a303 OK 2025/04/05 01:55:25 DEBUG : dst/three.txt: md5 = af45d83d482e4d753c4bbdc4f5c25890 OK 2025/04/05 01:55:25 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/dst" 2025/04/05 01:55:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst.bin" 2025/04/05 01:55:26 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst.bin: Auto set use_segments_container to true 2025/04/05 01:55:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst" 2025/04/05 01:55:32 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst: Auto set use_segments_container to true 2025/04/05 01:55:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/05 01:55:53 INFO : one: Copied (server-side copy) to: one.bak 2025/04/05 01:55:53 INFO : one: Deleted 2025/04/05 01:55:53 DEBUG : one: md5 = 97ac325820b26f9235345736eb10f856 OK 2025/04/05 01:55:53 INFO : one: Copied (new) 2025/04/05 01:55:53 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:55:53 DEBUG : two: Unchanged skipping 2025/04/05 01:55:53 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/05 01:56:03 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/05 01:56:09 INFO : three.txt: Deleted 2025/04/05 01:56:14 DEBUG : three.txt: md5 = 5ff4befd4cb80d79ec9b2067aa125c3c OK 2025/04/05 01:56:14 INFO : three.txt: Copied (new) 2025/04/05 01:56:20 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/05 01:56:30 INFO : one: Copied (server-side copy) to: one.bak 2025/04/05 01:56:30 INFO : one: Deleted 2025/04/05 01:56:30 DEBUG : one: md5 = beb2223029fbffe9ef379dbd068bfc92 OK 2025/04/05 01:56:30 INFO : one: Copied (new) 2025/04/05 01:56:30 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:56:30 DEBUG : two: Unchanged skipping 2025/04/05 01:56:35 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/04/05 01:56:41 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/05 01:56:46 INFO : three.txt: Deleted 2025/04/05 01:56:51 DEBUG : three.txt: md5 = a7a452e4a1aef18c732b5d65bef3f630 OK 2025/04/05 01:56:51 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (112.97s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:57:13 DEBUG : dst/one: md5 = 5806dc2a2e1c17a0f149f953ea251072 OK 2025/04/05 01:57:13 DEBUG : dst/two: md5 = 104878ed9f1dfe2dc7f098c9c7be0548 OK 2025/04/05 01:57:18 DEBUG : dst/three.txt: md5 = 4092a7f2cf7b599e690f48e2a4f8b2d4 OK 2025/04/05 01:57:19 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qevofib4raqo/dst" 2025/04/05 01:57:19 DEBUG : Config file has changed externally - reloading 2025/04/05 01:57:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst.bin" 2025/04/05 01:57:19 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst.bin: Auto set use_segments_container to true 2025/04/05 01:57:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qevofib4raqo/dst" 2025/04/05 01:57:25 DEBUG : Swift container crypt path rclone-test-qevofib4raqo/dst: Auto set use_segments_container to true 2025/04/05 01:57:30 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/05 01:57:41 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/05 01:57:41 INFO : one: Deleted 2025/04/05 01:57:41 DEBUG : one: md5 = 81bc6df45eeb6cada0e0cfb38534cee7 OK 2025/04/05 01:57:41 INFO : one: Copied (new) 2025/04/05 01:57:41 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:57:41 DEBUG : two: Unchanged skipping 2025/04/05 01:57:41 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/05 01:57:52 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/05 01:57:57 INFO : three.txt: Deleted 2025/04/05 01:58:02 DEBUG : three.txt: md5 = 7b17a7c76ea225435a7df51c06cb92e5 OK 2025/04/05 01:58:02 INFO : three.txt: Copied (new) 2025/04/05 01:58:13 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/05 01:58:19 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/05 01:58:19 INFO : one: Deleted 2025/04/05 01:58:19 DEBUG : one: md5 = 416b6868aa1f756e1cbbb539a5b4cb00 OK 2025/04/05 01:58:19 INFO : one: Copied (new) 2025/04/05 01:58:19 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:58:19 DEBUG : two: Unchanged skipping 2025/04/05 01:58:19 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/04/05 01:58:24 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/05 01:58:30 INFO : three.txt: Deleted 2025/04/05 01:58:35 DEBUG : three.txt: md5 = 83110ca1ffa6fc1ca4e739c1fe036fb5 OK 2025/04/05 01:58:35 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (89.19s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:58:42 DEBUG : Testêé: md5 = 98232556b44926118bde23eebaea47e0 OK 2025/04/05 01:58:42 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/04/05 01:58:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:58:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:58:43 DEBUG : Testêé: md5 = 532f8093df1d2aa3c7e63affd9bc19ce OK 2025/04/05 01:58:43 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/04/05 01:58:43 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (1.56s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:58:44 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/05 01:58:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:58:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:58:49 DEBUG : existing: md5 = fca738d5aa2bc1522c42cbaea8b64197 OK 2025/04/05 01:58:49 INFO : existing: Copied (new) 2025/04/05 01:58:49 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:58:49 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/04/05 01:58:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:58:49 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/04/05 01:58:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:58:49 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': not deleting files as there were IO errors 2025/04/05 01:58:49 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncImmutable (17.30s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:59:01 DEBUG : EXISTING: md5 = 56ccf5b02b89a190573ea9701f0f7c81 OK 2025/04/05 01:59:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 01:59:01 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 01:59:01 DEBUG : existing: Unchanged skipping 2025/04/05 01:59:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 01:59:01 DEBUG : Waiting for deletions to finish 2025/04/05 01:59:01 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.16s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.24s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", 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-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", 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-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.38s) --- SKIP: TestMaxTransfer/Hard (0.19s) --- SKIP: TestMaxTransfer/Soft (0.10s) --- SKIP: TestMaxTransfer/Cautious (0.10s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 01:59:03 DEBUG : both0: md5 = 7c5350426013641b7d9c6142e0bc8a09 OK 2025/04/05 01:59:08 DEBUG : only0: md5 = cc40e9e0b3ec4cd4bb4cc7ca582017c6 OK 2025/04/05 01:59:08 DEBUG : both1: md5 = b333974f68f5d0cf6369fa42ced15889 OK 2025/04/05 01:59:09 DEBUG : only1: md5 = fd0216244255a51f8d8739b7bc7c2226 OK 2025/04/05 01:59:14 DEBUG : both2: md5 = 5db9d878c0651c71d34c0fbbf2f9b9d5 OK 2025/04/05 01:59:20 DEBUG : only2: md5 = 697236aebe3b9c2e44328f83df8d1ec6 OK 2025/04/05 01:59:26 DEBUG : both3: md5 = 1a7d05cb5be600f99bf864b4fbc26ebe OK 2025/04/05 01:59:31 DEBUG : only3: md5 = d9cb15132a517c7be872ffcd90ede965 OK 2025/04/05 01:59:31 DEBUG : both4: md5 = 1d5b784a10309348feb0fff130f95748 OK 2025/04/05 01:59:32 DEBUG : only4: md5 = f8edcde3181f2fdeaeb761fc5dfe17d3 OK 2025/04/05 01:59:37 DEBUG : both5: md5 = 4ba8b40babee03b173159ada527b9a36 OK 2025/04/05 01:59:37 DEBUG : only5: md5 = 6ca5c96dd5cc019ba6e99f3870add97b OK 2025/04/05 01:59:43 DEBUG : both6: md5 = f6d8a4e5536284cb5cd0ba02c59de749 OK 2025/04/05 01:59:48 DEBUG : only6: md5 = da4db1a8fef3a958e23fc51b01b3f6ce OK 2025/04/05 01:59:54 DEBUG : both7: md5 = 21bfaf96d6e614ebe674b99e1910bc3e OK 2025/04/05 01:59:55 DEBUG : only7: md5 = 96ed587573bc95fc358eace8cb471e72 OK 2025/04/05 02:00:00 DEBUG : both8: md5 = 6f81e54fca9f1db5914d6c0db55dbe06 OK 2025/04/05 02:00:05 DEBUG : only8: md5 = f523275664f0a7a8e0b629cde96ec269 OK 2025/04/05 02:00:06 DEBUG : both9: md5 = d90dc49e59d87d34ee64d7dbe331c8bf OK 2025/04/05 02:00:06 DEBUG : only9: md5 = acaf30848bb5e2f2ec5067439295408a OK 2025/04/05 02:00:12 DEBUG : both10: md5 = 52960ee6e7eedb00f9ed753856eb7147 OK 2025/04/05 02:00:12 DEBUG : only10: md5 = be10ac5f397b268ea7449703f765160c OK 2025/04/05 02:00:17 DEBUG : both11: md5 = 39db3c19c82966b9ecf2a11803240938 OK 2025/04/05 02:00:17 DEBUG : only11: md5 = 71924e10b21c0770aad0e24d01db8a8d OK 2025/04/05 02:00:23 DEBUG : both12: md5 = 6044c70e03bc56f4e86ed074a6bd09d3 OK 2025/04/05 02:00:29 DEBUG : only12: md5 = 1e6f46197a61829ca0ada897040895a4 OK 2025/04/05 02:00:34 DEBUG : both13: md5 = e4428c22d1c75c67b40c97ad7143c9c2 OK 2025/04/05 02:00:40 DEBUG : only13: md5 = 9cdf212cbf09425bbb69d60b32e3981e OK 2025/04/05 02:00:45 DEBUG : both14: md5 = a0a58288b2084704dbaa39306df284d8 OK 2025/04/05 02:00:45 DEBUG : only14: md5 = 784efbaf4a572ec5c82de5187deb2235 OK 2025/04/05 02:00:46 DEBUG : both15: md5 = c7c7e55602311cc646b6893b09dc4ab4 OK 2025/04/05 02:00:51 DEBUG : only15: md5 = a50a8ab3caa122bed50bc43f8fe3e46e OK 2025/04/05 02:00:51 DEBUG : both16: md5 = 2a3c6dbed2cce51329bdbf9aa0380695 OK 2025/04/05 02:00:57 DEBUG : only16: md5 = fd284136da32d468776f840c2da40d8a OK 2025/04/05 02:01:02 DEBUG : both17: md5 = e07613ddcf2c8b0bd3f956600a08b559 OK 2025/04/05 02:01:07 DEBUG : only17: md5 = cb30d36c73b2aa9a7d5ca4ff5844210a OK 2025/04/05 02:01:13 DEBUG : both18: md5 = 9f504ce6423caed29bb3f035b95674a7 OK 2025/04/05 02:01:13 DEBUG : only18: md5 = 4507fc47fb76e494fe84be62617e922e OK 2025/04/05 02:01:18 DEBUG : both19: md5 = be2be8ea0b021d083c0ef085f7263b01 OK 2025/04/05 02:01:19 DEBUG : only19: md5 = 6e8f0d7efbf07d68bdda4a4ce01e0cd2 OK 2025/04/05 02:01:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 02:01:46 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:46 DEBUG : both0: Unchanged skipping 2025/04/05 02:01:46 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:46 DEBUG : both1: Unchanged skipping 2025/04/05 02:01:46 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:46 DEBUG : both10: Unchanged skipping 2025/04/05 02:01:46 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:46 DEBUG : both11: Unchanged skipping 2025/04/05 02:01:46 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:46 DEBUG : both13: Unchanged skipping 2025/04/05 02:01:46 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:46 DEBUG : both15: Unchanged skipping 2025/04/05 02:01:46 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:46 DEBUG : both16: Unchanged skipping 2025/04/05 02:01:46 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:46 DEBUG : both18: Unchanged skipping 2025/04/05 02:01:46 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:46 DEBUG : both19: Unchanged skipping 2025/04/05 02:01:51 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:51 DEBUG : both12: Unchanged skipping 2025/04/05 02:01:51 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:51 DEBUG : both14: Unchanged skipping 2025/04/05 02:01:51 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:51 DEBUG : both3: Unchanged skipping 2025/04/05 02:01:51 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:51 DEBUG : both4: Unchanged skipping 2025/04/05 02:01:51 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:51 DEBUG : both17: Unchanged skipping 2025/04/05 02:01:51 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:51 DEBUG : both5: Unchanged skipping 2025/04/05 02:01:51 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:51 DEBUG : both7: Unchanged skipping 2025/04/05 02:01:51 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:51 DEBUG : both9: Unchanged skipping 2025/04/05 02:01:51 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:51 DEBUG : both2: Unchanged skipping 2025/04/05 02:01:56 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:56 DEBUG : both6: Unchanged skipping 2025/04/05 02:01:56 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:01:56 DEBUG : both8: Unchanged skipping 2025/04/05 02:01:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 02:01:56 DEBUG : Waiting for deletions to finish 2025/04/05 02:01:56 INFO : only18: Deleted 2025/04/05 02:02:01 INFO : only3: Deleted 2025/04/05 02:02:01 INFO : only11: Deleted 2025/04/05 02:02:02 INFO : only8: Deleted 2025/04/05 02:02:06 INFO : only2: Deleted 2025/04/05 02:02:06 INFO : only5: Deleted 2025/04/05 02:02:06 INFO : only17: Deleted 2025/04/05 02:02:07 INFO : only13: Deleted 2025/04/05 02:02:07 INFO : only10: Deleted 2025/04/05 02:02:07 INFO : only1: Deleted 2025/04/05 02:02:07 INFO : only16: Deleted 2025/04/05 02:02:07 INFO : only7: Deleted 2025/04/05 02:02:07 INFO : only19: Deleted 2025/04/05 02:02:07 INFO : only4: Deleted 2025/04/05 02:02:07 INFO : only9: Deleted 2025/04/05 02:02:12 INFO : only15: Deleted 2025/04/05 02:02:12 INFO : only14: Deleted 2025/04/05 02:02:12 INFO : only6: Deleted 2025/04/05 02:02:13 INFO : only12: Deleted 2025/04/05 02:02:17 INFO : only0: Deleted 2025/04/05 02:02:17 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (323.53s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 02:04:26 DEBUG : both0: md5 = 42f65124f0ce61e013d253bc843c8755 OK 2025/04/05 02:04:31 DEBUG : only0: md5 = 140898fb4899ac872a63843590d033d0 OK 2025/04/05 02:04:31 DEBUG : both1: md5 = 9e167111931ab37b46246ec5370f9f8b OK 2025/04/05 02:04:32 DEBUG : only1: md5 = 284173030c1a1e56d7f2b1d39f74216a OK 2025/04/05 02:04:37 DEBUG : both2: md5 = caeb8694af4268470db4d6b5b21fb83d OK 2025/04/05 02:04:42 DEBUG : only2: md5 = 1c4ad917b490250f03ccb1e92822a75d OK 2025/04/05 02:04:47 DEBUG : both3: md5 = f988da19f387ca6a2fabe18aa7d80aba OK 2025/04/05 02:04:52 DEBUG : only3: md5 = 0348c6c86271dc249f0419f81872d8e3 OK 2025/04/05 02:04:53 DEBUG : both4: md5 = 68cd9ef0b527f6cc6c196f4924dc946c OK 2025/04/05 02:04:53 DEBUG : only4: md5 = 2bfffd3d9cdda6874e0cc0d24724fbd4 OK 2025/04/05 02:04:58 DEBUG : both5: md5 = 931db5f8daa3dfbe0db632029ca47b7e OK 2025/04/05 02:04:58 DEBUG : only5: md5 = 9883736cda6f8ec0108e6eb7d112e6c8 OK 2025/04/05 02:05:03 DEBUG : both6: md5 = 6d02d0a789e3db879bef5b4bae0a09d1 OK 2025/04/05 02:05:09 DEBUG : only6: md5 = 2eaca1784346e9aea0ca321a1ab8ca19 OK 2025/04/05 02:05:14 DEBUG : both7: md5 = cde4c514554a6c0e4c62683cd97b65ba OK 2025/04/05 02:05:14 DEBUG : only7: md5 = 5af81b754b9cb6cf14a5d8cdc2e2aaef OK 2025/04/05 02:05:19 DEBUG : both8: md5 = fd41f456fe79293c313685f9017ed0d8 OK 2025/04/05 02:05:24 DEBUG : only8: md5 = 559162943fbc82667e0aee07b9bc5582 OK 2025/04/05 02:05:25 DEBUG : both9: md5 = e1b4ba6db2e144140e494278d7212072 OK 2025/04/05 02:05:25 DEBUG : only9: md5 = 57591212259736a266b5df59143918b8 OK 2025/04/05 02:05:30 DEBUG : both10: md5 = db1bf3cdbe783db09b85293843dce7d3 OK 2025/04/05 02:05:30 DEBUG : only10: md5 = b0f08da7229fdcb73efd3d70621bd100 OK 2025/04/05 02:05:36 DEBUG : both11: md5 = c056c9cd48f552829885b8fee2284a08 OK 2025/04/05 02:05:36 DEBUG : only11: md5 = 9b6af0c9ec90bce602b629b3aea5b3a3 OK 2025/04/05 02:05:41 DEBUG : both12: md5 = 8abb623d78707d6ba379a3187ae0895b OK 2025/04/05 02:05:46 DEBUG : only12: md5 = f2500769db9dfbaf570a029eab2d90d8 OK 2025/04/05 02:05:52 DEBUG : both13: md5 = 5bbebd1bf5ccb85fefda7675b83c5b0f OK 2025/04/05 02:05:57 DEBUG : only13: md5 = e238f70433da4948292c4ebdc714977c OK 2025/04/05 02:06:02 DEBUG : both14: md5 = ce28a4a0254b57aa3a4b9ea606b85fc8 OK 2025/04/05 02:06:02 DEBUG : only14: md5 = f9aaaf5149aa822e82aa9f01a77d3d2d OK 2025/04/05 02:06:03 DEBUG : both15: md5 = d369d05ed5e168e1b3e9ff290600bc05 OK 2025/04/05 02:06:08 DEBUG : only15: md5 = cbf76d151edf6fbf1c8b3964987660c0 OK 2025/04/05 02:06:08 DEBUG : both16: md5 = c7b4ee948bad10e68866d1e1e74a7942 OK 2025/04/05 02:06:13 DEBUG : only16: md5 = 45162deb591bb22b36a3113239583778 OK 2025/04/05 02:06:18 DEBUG : both17: md5 = 7f290241f12876e48be92807cb2872f8 OK 2025/04/05 02:06:24 DEBUG : only17: md5 = aaf99dfc5eaf22d3e69b39c93259b948 OK 2025/04/05 02:06:29 DEBUG : both18: md5 = 0e6980009818c2889dfb2c3b29795918 OK 2025/04/05 02:06:29 DEBUG : only18: md5 = 248185b23792d05d96016baf7d3af204 OK 2025/04/05 02:06:34 DEBUG : both19: md5 = 288075406cdc70f22b19be1c49b4e7a5 OK 2025/04/05 02:06:34 DEBUG : only19: md5 = c5986e929f1db6ca314f4be7ae466005 OK 2025/04/05 02:07:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for checks to finish 2025/04/05 02:07:26 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:26 DEBUG : both1: Unchanged skipping 2025/04/05 02:07:26 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:26 DEBUG : both11: Unchanged skipping 2025/04/05 02:07:26 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:26 DEBUG : both0: Unchanged skipping 2025/04/05 02:07:26 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:26 DEBUG : both12: Unchanged skipping 2025/04/05 02:07:26 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:26 DEBUG : both13: Unchanged skipping 2025/04/05 02:07:26 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:26 DEBUG : both15: Unchanged skipping 2025/04/05 02:07:27 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:27 DEBUG : both16: Unchanged skipping 2025/04/05 02:07:27 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:27 DEBUG : both18: Unchanged skipping 2025/04/05 02:07:31 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:31 DEBUG : both10: Unchanged skipping 2025/04/05 02:07:31 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:31 DEBUG : both2: Unchanged skipping 2025/04/05 02:07:31 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:31 DEBUG : both14: Unchanged skipping 2025/04/05 02:07:32 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:32 DEBUG : both4: Unchanged skipping 2025/04/05 02:07:32 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:32 DEBUG : both17: Unchanged skipping 2025/04/05 02:07:32 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:32 DEBUG : both5: Unchanged skipping 2025/04/05 02:07:32 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:32 DEBUG : both19: Unchanged skipping 2025/04/05 02:07:32 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:32 DEBUG : both8: Unchanged skipping 2025/04/05 02:07:32 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:32 DEBUG : both9: Unchanged skipping 2025/04/05 02:07:32 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/04/05 02:07:32 DEBUG : only10: md5 = 08d0a981736022ec5ecf1220a510ab0f OK 2025/04/05 02:07:32 INFO : only10: Copied (replaced existing) 2025/04/05 02:07:32 DEBUG : only11: md5 = fad852e7648ea1fe65b92610747bcf98 OK 2025/04/05 02:07:32 INFO : only11: Copied (replaced existing) 2025/04/05 02:07:32 DEBUG : only1: md5 = cbca24e73f840a27f93b1055a4104786 OK 2025/04/05 02:07:32 INFO : only1: Copied (replaced existing) 2025/04/05 02:07:32 DEBUG : only14: md5 = 2360fe40a459af56b39bced848131ee5 OK 2025/04/05 02:07:32 INFO : only14: Copied (replaced existing) 2025/04/05 02:07:36 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:36 DEBUG : both3: Unchanged skipping 2025/04/05 02:07:37 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:37 DEBUG : both6: Unchanged skipping 2025/04/05 02:07:37 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/05 02:07:37 DEBUG : both7: Unchanged skipping 2025/04/05 02:07:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Waiting for transfers to finish 2025/04/05 02:07:37 DEBUG : only0: md5 = 097cba2afa9bdd9467b2b58508c47be2 OK 2025/04/05 02:07:37 INFO : only0: Copied (replaced existing) 2025/04/05 02:07:37 DEBUG : only13: md5 = ca2626f4dc0cdddade1e1456fac05a76 OK 2025/04/05 02:07:37 INFO : only13: Copied (replaced existing) 2025/04/05 02:07:37 DEBUG : only15: md5 = 84af7c08ec590ca2755291ce3c034881 OK 2025/04/05 02:07:37 INFO : only15: Copied (replaced existing) 2025/04/05 02:07:38 DEBUG : only18: md5 = e93426ff13efdff02f84b6b43230c7e1 OK 2025/04/05 02:07:38 INFO : only18: Copied (replaced existing) 2025/04/05 02:07:38 DEBUG : only19: md5 = e4653b755f72fe6ae9e99589b3caca4a OK 2025/04/05 02:07:38 INFO : only19: Copied (replaced existing) 2025/04/05 02:07:42 DEBUG : only16: md5 = 40cbe7c19d1f8dc878f6c74cdbf0fb36 OK 2025/04/05 02:07:42 INFO : only16: Copied (replaced existing) 2025/04/05 02:07:42 DEBUG : only12: md5 = 607f9aad76901b57efc6fddcc24f02b3 OK 2025/04/05 02:07:42 INFO : only12: Copied (replaced existing) 2025/04/05 02:07:42 DEBUG : only4: md5 = a6b356e9fdd9d3c9d53324e7b3d202e9 OK 2025/04/05 02:07:42 INFO : only4: Copied (replaced existing) 2025/04/05 02:07:43 DEBUG : only17: md5 = 839c49a67d2489bc2d13dd71e2d59ae5 OK 2025/04/05 02:07:43 INFO : only17: Copied (replaced existing) 2025/04/05 02:07:43 DEBUG : only5: md5 = f0ea660467f35cc95216cede07fa3033 OK 2025/04/05 02:07:43 INFO : only5: Copied (replaced existing) 2025/04/05 02:07:43 DEBUG : only7: md5 = e34c47a511d8f411c98cd361a6737054 OK 2025/04/05 02:07:43 INFO : only7: Copied (replaced existing) 2025/04/05 02:07:47 DEBUG : only3: md5 = 72d4ba1a911879e03daf27f3e3c2af0d OK 2025/04/05 02:07:47 INFO : only3: Copied (replaced existing) 2025/04/05 02:07:47 DEBUG : only9: md5 = 4221bbde17bb84269402d0dea45bde59 OK 2025/04/05 02:07:47 INFO : only9: Copied (replaced existing) 2025/04/05 02:07:48 DEBUG : only2: md5 = a9f653bd884dc848d967c4da4ed05979 OK 2025/04/05 02:07:48 INFO : only2: Copied (replaced existing) 2025/04/05 02:07:48 DEBUG : only8: md5 = 52e66aff62776c92838c4ce13e56329e OK 2025/04/05 02:07:48 INFO : only8: Copied (replaced existing) 2025/04/05 02:07:53 DEBUG : only6: md5 = d6fae7dc088718261b8d878addc0e4f4 OK 2025/04/05 02:07:53 INFO : only6: Copied (replaced existing) 2025/04/05 02:07:53 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (425.81s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 02:11:32 DEBUG : empty_dir: Making directory with metadata 2025/04/05 02:11:32 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/05 02:11:32 DEBUG : empty_on_remote: Making directory with metadata 2025/04/05 02:11:32 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/05 02:11:32 INFO : empty_on_remote: Making directory 2025/04/05 02:11:32 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 02:11:33 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/04/05 02:11:33 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/04/05 02:11:33 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/04/05 02:11:33 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTime (2.74s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 02:11:35 DEBUG : empty_dir: Making directory with metadata 2025/04/05 02:11:35 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/05 02:11:35 DEBUG : empty_on_remote: Making directory with metadata 2025/04/05 02:11:35 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/05 02:11:35 INFO : empty_on_remote: Making directory 2025/04/05 02:11:35 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 02:11:35 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/04/05 02:11:35 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/04/05 02:11:35 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/04/05 02:11:35 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/04/05 02:11:35 INFO : empty_dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (2.29s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 02:11:37 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/05 02:11:37 INFO : sub dir: Making directory 2025/04/05 02:11:37 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-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (12.21s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" 2025/04/05 02:11:49 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/05 02:11:49 INFO : sub dir: Making directory 2025/04/05 02:11:49 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-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo'", Local "Local file system at /tmp/rclone3002897795", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (22.25s) PASS 2025/04/05 02:12:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qevofib4raqo': Purge remote 2025/04/05 02:12:11 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 54m56.208849838s (try 1/5)