"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 2/5) 2025/05/16 02:08:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi" 2025/05/16 02:08:10 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/05/16 02:08:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi.bin" 2025/05/16 02:08:10 DEBUG : Swift container crypt path rclone-test-zugatar4beqi.bin: Auto set use_segments_container to true 2025/05/16 02:08:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi" 2025/05/16 02:08:15 DEBUG : Config file has changed externally - reloading 2025/05/16 02:08:16 DEBUG : Swift container crypt path rclone-test-zugatar4beqi: Auto set use_segments_container to true 2025/05/16 02:08:21 DEBUG : Creating backend with remote "/tmp/rclone3889086274" === 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-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:08:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:08:22 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/05/16 02:08:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:08:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.86s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:08:22 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/05/16 02:08:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:08:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:08:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:08:27 DEBUG : sub dir/hello world: md5 = 7af454102d251a2ef668114c93557f90 OK 2025/05/16 02:08:27 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:08:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (15.92s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.10s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.10s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:08:38 DEBUG : Creating backend with remote "/non-existing" 2025/05/16 02:08:38 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/05/16 02:08:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:08:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.24s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:08:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:08:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:08:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:08:49 DEBUG : sub dir/hello world: md5 = 52c74fdd19108a1bb078d58d02677768 OK 2025/05/16 02:08:49 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyNoTraverse (21.42s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:09:00 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Running all checks before starting transfers 2025/05/16 02:09:00 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:09:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:09:00 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Checks finished, now starting transfers 2025/05/16 02:09:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:09:05 DEBUG : sub dir/hello world: md5 = 1c3fb78497e28ecb1c0b70ec3c3f188a OK 2025/05/16 02:09:05 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyCheckFirst (16.03s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:09:16 ERROR : Ignoring --no-traverse with sync 2025/05/16 02:09:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:09:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:09:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:09:21 DEBUG : sub dir/hello world: md5 = b1393f7b6cba913c92ac17afab409b52 OK 2025/05/16 02:09:21 INFO : sub dir/hello world: Copied (new) 2025/05/16 02:09:21 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncNoTraverse (10.85s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:09:27 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/05/16 02:09:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:09:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:09:27 DEBUG : hello world2: md5 = b52e326424cfbb11db6bc75f7e12e6dd OK 2025/05/16 02:09:27 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyWithDepth (1.47s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:09:28 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:09:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:09:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:09:29 DEBUG : potato2: md5 = 2af741098e6276343f6ef1f0cc507e17 OK 2025/05/16 02:09:29 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (1.20s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:09:34 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:09:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:09:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:09:35 DEBUG : potato2: md5 = 1f8619259a34a6f08212c770bc5cc6ad OK 2025/05/16 02:09:35 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (5.85s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:09:35 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/05/16 02:09:35 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/05/16 02:09:35 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/05/16 02:09:35 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/05/16 02:09:35 INFO : sub dir: Making directory 2025/05/16 02:09:35 INFO : sub dir2: Making directory 2025/05/16 02:09:35 INFO : sub dir2/sub sub dir2: Making directory 2025/05/16 02:09:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:09:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:09:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:09:40 DEBUG : sub dir/hello world: md5 = 4a1f5f2477a091861424fb138c891ab9 OK 2025/05/16 02:09:40 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2025/05/16 02:09:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (16.02s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:09:51 INFO : sub dir2: Making directory 2025/05/16 02:09:51 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/05/16 02:09:51 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/05/16 02:09:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:09:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:09:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:09:56 DEBUG : sub dir/hello world: md5 = 94798737d219c1f54a0f487a74af23b0 OK 2025/05/16 02:09:56 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (15.76s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:10:07 DEBUG : sub dir2: Making directory with metadata 2025/05/16 02:10:07 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/05/16 02:10:07 INFO : sub dir: Making directory 2025/05/16 02:10:07 INFO : sub dir2: Making directory 2025/05/16 02:10:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:10:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:10:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:10:12 DEBUG : sub dir/hello world: md5 = 6e97ce6481e773135e4ea0cfe1dc6012 OK 2025/05/16 02:10:12 INFO : sub dir/hello world: Copied (new) 2025/05/16 02:10:12 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/05/16 02:10:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/05/16 02:10:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (11.45s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.10s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:10:19 INFO : sub dir2: Making directory 2025/05/16 02:10:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:10:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:10:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:10:24 DEBUG : sub dir/hello world: md5 = ea053cebca85d6be2ec73d68e3d1bf1d OK 2025/05/16 02:10:24 INFO : sub dir/hello world: Copied (new) 2025/05/16 02:10:24 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (10.88s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:10:29 DEBUG : sub dir2: Making directory with metadata 2025/05/16 02:10:29 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/05/16 02:10:29 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/05/16 02:10:30 INFO : sub dir: Making directory 2025/05/16 02:10:30 INFO : sub dir2: Making directory 2025/05/16 02:10:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:10:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:10:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:10:35 DEBUG : sub dir/hello world: md5 = ab87efa1844b17c3d8ed80a616a2d140 OK 2025/05/16 02:10:35 INFO : sub dir/hello world: Copied (new) 2025/05/16 02:10:35 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/05/16 02:10:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (10.98s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.12s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:10:41 INFO : sub dir2: Making directory 2025/05/16 02:10:41 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:10:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:10:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:10:46 DEBUG : sub dir/hello world: md5 = e7bae6c7604b366156500f7d35c4c857 OK 2025/05/16 02:10:46 INFO : sub dir/hello world: Copied (new) 2025/05/16 02:10:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (15.91s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:11:02 DEBUG : sub dir/hello world: md5 = b79c216957b13e8674a2e0fae15efb39 OK 2025/05/16 02:11:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-rogaxus2waqe" 2025/05/16 02:11:07 DEBUG : Config file has changed externally - reloading 2025/05/16 02:11:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rogaxus2waqe.bin" 2025/05/16 02:11:07 DEBUG : Swift container crypt path rclone-test-rogaxus2waqe.bin: Auto set use_segments_container to true 2025/05/16 02:11:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rogaxus2waqe" 2025/05/16 02:11:13 DEBUG : Swift container crypt path rclone-test-rogaxus2waqe: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi' -> Encrypted drive 'TestCryptSwift:rclone-test-rogaxus2waqe' 2025/05/16 02:11:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:11:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rogaxus2waqe': Waiting for checks to finish 2025/05/16 02:11:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rogaxus2waqe': Waiting for transfers to finish 2025/05/16 02:11:29 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:11:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rogaxus2waqe': Purge remote 2025/05/16 02:11:29 DEBUG : Waiting for deletions to finish 2025/05/16 02:11:29 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (38.41s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:11:40 DEBUG : sub dir/hello world: md5 = d014ca209481d9341648af490d1c91d8 OK 2025/05/16 02:11:40 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/05/16 02:11:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:11:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:11:46 DEBUG : sub dir/hello world: md5 = 95299a994d1521deb2b7144365607fc8 OK 2025/05/16 02:11:46 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyOverSelf (21.43s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:12:01 DEBUG : sub dir/hello world: md5 = 3fc3289977b22056d51a5eaafcfac251 OK 2025/05/16 02:12:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-nawetif7zega" 2025/05/16 02:12:07 DEBUG : Config file has changed externally - reloading 2025/05/16 02:12:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nawetif7zega.bin" 2025/05/16 02:12:07 DEBUG : Swift container crypt path rclone-test-nawetif7zega.bin: Auto set use_segments_container to true 2025/05/16 02:12:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nawetif7zega" 2025/05/16 02:12:13 DEBUG : Swift container crypt path rclone-test-nawetif7zega: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi' -> Encrypted drive 'TestCryptSwift:rclone-test-nawetif7zega' 2025/05/16 02:12:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:12:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nawetif7zega': Waiting for checks to finish 2025/05/16 02:12:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nawetif7zega': Waiting for transfers to finish 2025/05/16 02:12:29 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:12:34 DEBUG : sub dir/hello world: md5 = 66416d7b6857bd42cbba18025434043b OK 2025/05/16 02:12:35 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/05/16 02:12:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nawetif7zega': Waiting for checks to finish 2025/05/16 02:12:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nawetif7zega': Waiting for transfers to finish 2025/05/16 02:12:40 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:12:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nawetif7zega': Purge remote 2025/05/16 02:12:40 DEBUG : Waiting for deletions to finish 2025/05/16 02:12:41 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (55.12s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:12:57 DEBUG : sub dir/hello world: md5 = 17e6338fc6de5d785dc77843a36fbbaa OK 2025/05/16 02:13:02 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/05/16 02:13:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:13:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:13:07 DEBUG : sub dir/hello world: md5 = 225695a65689e332d82eb1ae2117da38 OK 2025/05/16 02:13:07 INFO : sub dir/hello world: Copied (replaced existing) 2025/05/16 02:13:07 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestMoveOverSelf (31.78s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:13:28 DEBUG : sub dir/hello world: md5 = 5602798f43890da6ee9ee4796203f4f8 OK 2025/05/16 02:13:34 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wajolup3voba" 2025/05/16 02:13:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wajolup3voba.bin" 2025/05/16 02:13:34 DEBUG : Swift container crypt path rclone-test-wajolup3voba.bin: Auto set use_segments_container to true 2025/05/16 02:13:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wajolup3voba" 2025/05/16 02:13:39 DEBUG : Swift container crypt path rclone-test-wajolup3voba: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi' -> Encrypted drive 'TestCryptSwift:rclone-test-wajolup3voba' 2025/05/16 02:13:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:13:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wajolup3voba': Waiting for checks to finish 2025/05/16 02:13:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wajolup3voba': Waiting for transfers to finish 2025/05/16 02:13:56 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:14:07 DEBUG : sub dir/hello world: md5 = 77a08c8154329ce4c00898b904bbac51 OK 2025/05/16 02:14:12 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/05/16 02:14:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wajolup3voba': Waiting for checks to finish 2025/05/16 02:14:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wajolup3voba': Waiting for transfers to finish 2025/05/16 02:14:28 INFO : sub dir/hello world: Copied (server-side copy) 2025/05/16 02:14:33 INFO : sub dir/hello world: Deleted 2025/05/16 02:14:38 DEBUG : sub dir/hello world: md5 = 8e9befcfe2add27984742c21815cc1f0 OK 2025/05/16 02:14:39 DEBUG : testing file moves 2025/05/16 02:14:39 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/05/16 02:14:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wajolup3voba': Waiting for checks to finish 2025/05/16 02:14:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wajolup3voba': Waiting for transfers to finish 2025/05/16 02:14:54 INFO : sub dir/hello world: Copied (server-side copy) 2025/05/16 02:15:00 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wajolup3voba': Purge remote 2025/05/16 02:15:00 DEBUG : Waiting for deletions to finish 2025/05/16 02:15:10 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (107.56s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:16 DEBUG : sub dir/hello world: md5 = 9d0518de3096decc746a57ac89fda39d OK 2025/05/16 02:15:16 ERROR : : error listing: directory not found 2025/05/16 02:15:16 INFO : Local file system at /tmp/rclone3889086274: Making directory 2025/05/16 02:15:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:15:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyAfterDelete (16.24s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:32 DEBUG : sub dir/hello world: md5 = 08d76c9ba43926815ac80c53428bc2fc OK 2025/05/16 02:15:38 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:15:38 DEBUG : Local file system at /tmp/rclone3889086274: Waiting for checks to finish 2025/05/16 02:15:38 DEBUG : Local file system at /tmp/rclone3889086274: Waiting for transfers to finish 2025/05/16 02:15:38 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/05/16 02:15:38 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyRedownload (16.03s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:43 DEBUG : check sum: Need to transfer - File not found at Destination 2025/05/16 02:15:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:15:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:15:44 DEBUG : check sum: md5 = 6c0a16cf6601e76a6ec7574dcda79d39 OK 2025/05/16 02:15:44 INFO : check sum: Copied (new) 2025/05/16 02:15:44 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:44 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/05/16 02:15:44 DEBUG : check sum: Size of src and dst objects identical 2025/05/16 02:15:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:15:44 DEBUG : check sum: Unchanged skipping 2025/05/16 02:15:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:15:44 DEBUG : Waiting for deletions to finish 2025/05/16 02:15:44 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (1.71s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:45 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/05/16 02:15:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:15:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:15:45 DEBUG : sizeonly: md5 = 0c2fa4623e393c73541a1da0ff65dc0d OK 2025/05/16 02:15:45 INFO : sizeonly: Copied (new) 2025/05/16 02:15:45 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:45 DEBUG : sizeonly: Sizes identical 2025/05/16 02:15:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:15:45 DEBUG : sizeonly: Unchanged skipping 2025/05/16 02:15:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:15:45 DEBUG : Waiting for deletions to finish 2025/05/16 02:15:45 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncSizeOnly (1.64s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:46 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/05/16 02:15:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:15:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:15:47 DEBUG : ignore-size: md5 = 084bc6cbd3eb4a450b20c69e9fff800e OK 2025/05/16 02:15:47 INFO : ignore-size: Copied (new) 2025/05/16 02:15:47 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:15:48 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:15:48 DEBUG : ignore-size: Unchanged skipping 2025/05/16 02:15:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:15:48 DEBUG : Waiting for deletions to finish 2025/05/16 02:15:48 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (2.38s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:15:59 DEBUG : existing: md5 = a934873e9306d4145492b58edbae881b OK fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:286: Sleeping for 6s just to make sure 2025/05/16 02:16:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:16:06 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:16:06 DEBUG : existing: Unchanged skipping 2025/05/16 02:16:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:16:06 DEBUG : Waiting for deletions to finish 2025/05/16 02:16:06 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:16:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:16:06 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/05/16 02:16:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:16:22 DEBUG : existing: md5 = 18b11c67a88c684b05456b85239424de OK 2025/05/16 02:16:22 INFO : existing: Copied (replaced existing) 2025/05/16 02:16:22 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (43.40s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:16:32 DEBUG : existing: Need to transfer - File not found at Destination 2025/05/16 02:16:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:16:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:16:45 DEBUG : existing: md5 = 0d83b0214964a4aacf255c3658ee0b8d OK 2025/05/16 02:16:45 INFO : existing: Copied (new) 2025/05/16 02:16:45 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:16:50 DEBUG : existing: Destination exists, skipping 2025/05/16 02:16:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:16:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:16:50 DEBUG : Waiting for deletions to finish 2025/05/16 02:16:50 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (28.18s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:17:10 DEBUG : b/potato: md5 = 64cad835e34f2010fc29dece0a55f698 OK 2025/05/16 02:17:20 DEBUG : c/non empty space: md5 = 5c30070a3a9d0f113c679d78d877a747 OK 2025/05/16 02:17:20 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/05/16 02:17:21 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/05/16 02:17:21 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:17:21 DEBUG : c/non empty space: Unchanged skipping 2025/05/16 02:17:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:17:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:17:21 DEBUG : a/potato2: md5 = 8a337fe129c7d8da690bdc0c0e4d61d9 OK 2025/05/16 02:17:21 INFO : a/potato2: Copied (new) 2025/05/16 02:17:21 DEBUG : Waiting for deletions to finish 2025/05/16 02:17:26 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (40.07s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:17:46 DEBUG : empty space: md5 = c86f4d5f42b25fd94802960e70185aa8 OK 2025/05/16 02:17:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:17:51 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/05/16 02:17:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:17:51 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/05/16 02:17:51 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:17:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:17:56 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/05/16 02:17:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:18:02 DEBUG : empty space: md5 = 0c07cf2843cdc420f89ddcbfa2a4c21f OK 2025/05/16 02:18:02 INFO : empty space: Copied (replaced existing) 2025/05/16 02:18:02 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (37.11s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:1016: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.20s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:18:25 DEBUG : foo: md5 = 3d0318beeb8594225299aa0f26ec4df1 OK 2025/05/16 02:18:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:18:30 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/05/16 02:18:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:18:40 DEBUG : foo: md5 = 1d16edefc6479c73dc68e73c9e4c5b7b OK 2025/05/16 02:18:40 INFO : foo: Copied (replaced existing) 2025/05/16 02:18:40 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (43.09s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:19:06 DEBUG : empty space: md5 = aff36eec31d30828c4da51a979c308d4 OK 2025/05/16 02:19:07 DEBUG : potato: Need to transfer - File not found at Destination 2025/05/16 02:19:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:19:07 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:19:07 DEBUG : empty space: Unchanged skipping 2025/05/16 02:19:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:19:07 DEBUG : potato: md5 = 0e36e2b78c0c6349ecc3d40f78f4471d OK 2025/05/16 02:19:07 INFO : potato: Copied (new) 2025/05/16 02:19:07 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (12.76s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:19:14 DEBUG : potato: md5 = cc477e64f3c9daa6672f3f5c0efc0514 OK 2025/05/16 02:19:14 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/05/16 02:19:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:19:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:19:14 DEBUG : potato: md5 = e3c6eda8ecdeab1e0c496ce1727f60ea OK 2025/05/16 02:19:14 INFO : potato: Copied (replaced existing) 2025/05/16 02:19:14 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (1.79s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:19:16 DEBUG : potato: md5 = 54b0c9dd59ae9684ba9b8d1adcfc96a0 OK 2025/05/16 02:19:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:19:16 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/05/16 02:19:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:19:16 DEBUG : potato: md5 = f99c8b6a9af70b36bc51a102c27641a8 OK 2025/05/16 02:19:16 INFO : potato: Copied (replaced existing) 2025/05/16 02:19:16 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (1.93s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:19:18 DEBUG : potato: md5 = 5166b2f6b3e45c13a0ed7eb18c6d6dfa OK 2025/05/16 02:19:23 DEBUG : empty space: md5 = ea47c53e73faf784e2acef405458745c OK 2025/05/16 02:19:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:19:23 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/05/16 02:19:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:19:23 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:19:23 DEBUG : empty space: Unchanged skipping 2025/05/16 02:19:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:19:23 DEBUG : Waiting for deletions to finish 2025/05/16 02:19:23 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (16.76s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:19:34 DEBUG : potato: md5 = b351fff03d8734bfc7732de129b7aa04 OK 2025/05/16 02:19:39 DEBUG : empty space: md5 = 6bcd1c69ea76d1c3090b6b03bdd1d017 OK 2025/05/16 02:19:40 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:19:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:19:40 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:19:40 DEBUG : empty space: Unchanged skipping 2025/05/16 02:19:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:19:40 DEBUG : potato2: md5 = e39b0af14b27f2b02c9b01dd73dda0f4 OK 2025/05/16 02:19:40 INFO : potato2: Copied (new) 2025/05/16 02:19:40 DEBUG : Waiting for deletions to finish 2025/05/16 02:19:40 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (17.08s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:20:01 DEBUG : b/potato: md5 = aff0e77ad67137672951bbb90bfe2717 OK 2025/05/16 02:20:12 DEBUG : c/non empty space: md5 = 7efadd8475d10c3803a8206219b68829 OK 2025/05/16 02:20:12 INFO : d: Making directory 2025/05/16 02:20:12 INFO : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2025/05/16 02:20:18 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/05/16 02:20:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:20:18 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:20:18 DEBUG : c/non empty space: Unchanged skipping 2025/05/16 02:20:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:20:18 DEBUG : a/potato2: md5 = 69df50a3d0857ddd563bb91b50612c51 OK 2025/05/16 02:20:18 INFO : a/potato2: Copied (new) 2025/05/16 02:20:18 DEBUG : Waiting for deletions to finish 2025/05/16 02:20:23 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (48.32s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:20:50 DEBUG : b/potato: md5 = c85430ccf80ec78dede973d035a7aa94 OK 2025/05/16 02:20:59 DEBUG : c/non empty space: md5 = 00433af9323b3e118b8e8ec17758af81 OK 2025/05/16 02:20:59 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/05/16 02:21:04 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/05/16 02:21:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:21:05 DEBUG : a/potato2: md5 = c0e06bd206d5d19cac7344c565d3eaa0 OK 2025/05/16 02:21:05 INFO : a/potato2: Copied (new) 2025/05/16 02:21:09 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:21:09 DEBUG : c/non empty space: Unchanged skipping 2025/05/16 02:21:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:21:09 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': not deleting files as there were IO errors 2025/05/16 02:21:10 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (51.23s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:21:31 DEBUG : potato: md5 = 06e89dd9b1d10d8ca225caf2afc9f09a OK 2025/05/16 02:21:36 DEBUG : empty space: md5 = f84e08d86f97db4bbd70ddf94c667fd7 OK 2025/05/16 02:21:36 DEBUG : Waiting for deletions to finish 2025/05/16 02:21:36 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:21:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:21:36 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:21:36 DEBUG : empty space: Unchanged skipping 2025/05/16 02:21:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:21:37 DEBUG : potato2: md5 = 51af6fa985ef552a2573a6060464bdd6 OK 2025/05/16 02:21:37 INFO : potato2: Copied (new) 2025/05/16 02:21:37 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (12.14s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:21:43 DEBUG : potato: md5 = 394b0ea03ec9108267a4e135e49f02b8 OK 2025/05/16 02:21:48 DEBUG : empty space: md5 = dfc35f1cccf493d14504a029f606da41 OK 2025/05/16 02:21:48 DEBUG : Waiting for deletions to finish 2025/05/16 02:21:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:21:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:21:49 INFO : potato: Deleted 2025/05/16 02:21:49 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:21:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:21:49 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:21:49 DEBUG : empty space: Unchanged skipping 2025/05/16 02:21:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:21:49 DEBUG : potato2: md5 = adcee28ca2f4483435a3dd8be6e522ac OK 2025/05/16 02:21:49 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (12.17s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:21:55 DEBUG : potato: md5 = af69e2b9bbaa61cafce4ab13e87b7265 OK 2025/05/16 02:21:55 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:21:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:21:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:21:56 DEBUG : potato2: md5 = 49e58586643c30f7481e585e0963ede9 OK 2025/05/16 02:21:56 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (1.51s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:21:57 DEBUG : potato2: md5 = 69e486c2a481d007cd2039aec6415edb OK 2025/05/16 02:22:02 DEBUG : empty space: md5 = 343250ce0445eff039ab89991f7fdc5b OK 2025/05/16 02:22:07 DEBUG : enormous: Excluded (Size Filter) 2025/05/16 02:22:07 DEBUG : enormous: Excluded 2025/05/16 02:22:07 DEBUG : potato2: Excluded (Size Filter) 2025/05/16 02:22:07 DEBUG : potato2: Excluded 2025/05/16 02:22:07 DEBUG : potato2: Excluded (Size Filter) 2025/05/16 02:22:07 DEBUG : potato2: Excluded 2025/05/16 02:22:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:22:12 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:22:12 DEBUG : empty space: Unchanged skipping 2025/05/16 02:22:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:22:12 DEBUG : Waiting for deletions to finish 2025/05/16 02:22:12 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:22:12 DEBUG : enormous: Excluded (Size Filter) 2025/05/16 02:22:12 DEBUG : enormous: Excluded 2025/05/16 02:22:12 DEBUG : potato2: Excluded (Size Filter) 2025/05/16 02:22:12 DEBUG : potato2: Excluded 2025/05/16 02:22:13 DEBUG : potato2: Excluded (Size Filter) 2025/05/16 02:22:13 DEBUG : potato2: Excluded 2025/05/16 02:22:13 DEBUG : Local file system at /tmp/rclone3889086274: Waiting for checks to finish 2025/05/16 02:22:13 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:22:13 DEBUG : empty space: Unchanged skipping 2025/05/16 02:22:13 DEBUG : Local file system at /tmp/rclone3889086274: Waiting for transfers to finish 2025/05/16 02:22:13 DEBUG : Waiting for deletions to finish 2025/05/16 02:22:13 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncWithExclude (21.94s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:22:19 DEBUG : potato2: md5 = 85bbc5eff6b72abded5a07704cbc5f6a OK 2025/05/16 02:22:24 DEBUG : empty space: md5 = 7a0783969b55be9acbe61f27db88e166 OK 2025/05/16 02:22:24 DEBUG : enormous: md5 = d86510ca441096f780de696d705fc047 OK 2025/05/16 02:22:24 DEBUG : enormous: Excluded (Size Filter) 2025/05/16 02:22:24 DEBUG : enormous: Excluded 2025/05/16 02:22:24 DEBUG : potato2: Excluded (Size Filter) 2025/05/16 02:22:24 DEBUG : potato2: Excluded 2025/05/16 02:22:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:22:25 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:22:25 DEBUG : empty space: Unchanged skipping 2025/05/16 02:22:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:22:25 DEBUG : Waiting for deletions to finish 2025/05/16 02:22:25 INFO : potato2: Deleted 2025/05/16 02:22:25 INFO : enormous: Deleted 2025/05/16 02:22:25 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:22:25 DEBUG : Local file system at /tmp/rclone3889086274: Waiting for checks to finish 2025/05/16 02:22:25 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:22:25 DEBUG : empty space: Unchanged skipping 2025/05/16 02:22:25 DEBUG : Local file system at /tmp/rclone3889086274: Waiting for transfers to finish 2025/05/16 02:22:25 DEBUG : Waiting for deletions to finish 2025/05/16 02:22:25 INFO : enormous: Deleted 2025/05/16 02:22:25 INFO : potato2: Deleted 2025/05/16 02:22:25 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (17.91s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:22:42 DEBUG : one: md5 = d9ee796d87b4e4d627c3f076dfed5fce OK 2025/05/16 02:22:42 DEBUG : two: md5 = 78c2eace6be86686432e6077f936bdb9 OK 2025/05/16 02:22:42 DEBUG : three: md5 = 2e2d9163bbed01ee38f19d4976ae58e7 OK 2025/05/16 02:22:43 DEBUG : four: md5 = 3b7c265f85b71e46f3cfdb8b205836f3 OK 2025/05/16 02:22:43 DEBUG : five: Need to transfer - File not found at Destination 2025/05/16 02:22:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:22:43 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/05/16 02:22:43 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/05/16 02:22:43 DEBUG : three: Sizes identical 2025/05/16 02:22:43 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/05/16 02:22:44 DEBUG : four: md5 = 17e52927ad000be2808895a8ae370506 OK 2025/05/16 02:22:44 INFO : four: Copied (replaced existing) 2025/05/16 02:22:44 DEBUG : two: md5 = 66cef13aeae8e91ffee9df6df1cadb0e OK 2025/05/16 02:22:44 INFO : two: Copied (replaced existing) 2025/05/16 02:22:44 DEBUG : five: md5 = 2341558cc77d56c3c6f0c8b1ff1a4637 OK 2025/05/16 02:22:44 INFO : five: Copied (new) 2025/05/16 02:22:48 DEBUG : one: Destination is newer than source, skipping 2025/05/16 02:22:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:22:48 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (23.45s) === 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-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2025/05/16 02:23:00 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Ignoring --track-renames as the source and destination do not have a common hash 2025/05/16 02:23:00 DEBUG : potato: Need to transfer - File not found at Destination 2025/05/16 02:23:00 DEBUG : yam: Need to transfer - File not found at Destination 2025/05/16 02:23:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:23:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:23:00 DEBUG : potato: md5 = 6379ba673bccaa05caeda7666b730c1a OK 2025/05/16 02:23:00 INFO : potato: Copied (new) 2025/05/16 02:23:05 DEBUG : yam: md5 = fadfca43906c73ef87166cd5d7b001e2 OK 2025/05/16 02:23:05 INFO : yam: Copied (new) 2025/05/16 02:23:05 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:23:10 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Ignoring --track-renames as the source and destination do not have a common hash 2025/05/16 02:23:11 DEBUG : yaml: Need to transfer - File not found at Destination 2025/05/16 02:23:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:23:11 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:23:11 DEBUG : potato: Unchanged skipping 2025/05/16 02:23:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:23:11 DEBUG : yaml: md5 = b38451a432891b3c9e1c727b6a33d8f8 OK 2025/05/16 02:23:11 INFO : yaml: Copied (new) 2025/05/16 02:23:11 DEBUG : Waiting for deletions to finish 2025/05/16 02:23:16 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (18.32s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2025/05/16 02:23:18 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Making map for --track-renames 2025/05/16 02:23:18 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Finished making map for --track-renames 2025/05/16 02:23:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:23:18 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/16 02:23:18 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/05/16 02:23:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for renames to finish 2025/05/16 02:23:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:23:18 DEBUG : potato: md5 = cc397bce3e71552f7e615ad5980791d5 OK 2025/05/16 02:23:18 INFO : potato: Copied (new) 2025/05/16 02:23:23 DEBUG : yam: md5 = 0a9eb815c93782fc89947b9334ee6048 OK 2025/05/16 02:23:23 INFO : yam: Copied (new) 2025/05/16 02:23:23 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:23:24 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Making map for --track-renames 2025/05/16 02:23:24 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Finished making map for --track-renames 2025/05/16 02:23:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:23:24 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:23:24 DEBUG : potato: Unchanged skipping 2025/05/16 02:23:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for renames to finish 2025/05/16 02:23:34 INFO : yam: Copied (server-side copy) to: yaml 2025/05/16 02:23:39 INFO : yam: Deleted 2025/05/16 02:23:39 INFO : yaml: Renamed from "yam" 2025/05/16 02:23:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:23:39 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (22.37s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2025/05/16 02:23:41 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Making map for --track-renames 2025/05/16 02:23:41 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Finished making map for --track-renames 2025/05/16 02:23:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:23:41 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/05/16 02:23:41 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/05/16 02:23:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for renames to finish 2025/05/16 02:23:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:23:41 DEBUG : potato: md5 = 709440b8d88a5bef348fc1aecbfcc7b1 OK 2025/05/16 02:23:41 INFO : potato: Copied (new) 2025/05/16 02:23:46 DEBUG : sub/yam: md5 = ff195e513ad0e9246c0bbfab2c0fb8db OK 2025/05/16 02:23:46 INFO : sub/yam: Copied (new) 2025/05/16 02:23:46 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:23:46 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:23:46 DEBUG : potato: Unchanged skipping 2025/05/16 02:23:46 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Making map for --track-renames 2025/05/16 02:23:46 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Finished making map for --track-renames 2025/05/16 02:23:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:23:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for renames to finish 2025/05/16 02:24:07 INFO : sub/yam: Copied (server-side copy) to: yam 2025/05/16 02:24:12 INFO : sub/yam: Deleted 2025/05/16 02:24:12 INFO : yam: Renamed from "sub/yam" 2025/05/16 02:24:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:24:12 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (38.11s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:24:19 DEBUG : Creating backend with remote "/tmp/rclone3889086274/dir1" 2025/05/16 02:24:19 DEBUG : Config file has changed externally - reloading 2025/05/16 02:24:19 DEBUG : Creating backend with remote "/tmp/rclone3889086274/dir2" 2025/05/16 02:24:19 DEBUG : Local file system at /tmp/rclone3889086274/dir2: Using server-side directory move 2025/05/16 02:24:19 INFO : Local file system at /tmp/rclone3889086274/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/05/16 02:24:19 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/05/16 02:24:19 INFO : file1.txt: Moved (server-side) 2025/05/16 02:24:19 DEBUG : Local file system at /tmp/rclone3889086274/dir2: Waiting for checks to finish 2025/05/16 02:24:19 DEBUG : Local file system at /tmp/rclone3889086274/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.40s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:24:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:24:19 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/05/16 02:24:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:24:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:24:24 DEBUG : sub dir/hello world: md5 = a457d3f898404318cb1f659555ac7d0a OK 2025/05/16 02:24:24 INFO : sub dir/hello world: Copied (new) 2025/05/16 02:24:24 INFO : sub dir/hello world: Deleted 2025/05/16 02:24:25 DEBUG : nested/sub dir/file: md5 = 08d164889fbebd4088a721ab3e76cbcd OK 2025/05/16 02:24:25 INFO : nested/sub dir/file: Copied (new) 2025/05/16 02:24:25 INFO : nested/sub dir/file: Deleted 2025/05/16 02:24:25 INFO : sub dir: Removing directory 2025/05/16 02:24:25 INFO : nested/sub dir: Removing directory 2025/05/16 02:24:25 INFO : nested: Removing directory 2025/05/16 02:24:25 DEBUG : Local file system at /tmp/rclone3889086274: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (31.55s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:24:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/05/16 02:24:51 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/05/16 02:24:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:24:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:24:56 DEBUG : nested/sub dir/file: md5 = a75151df575b9d78aee3cd5cb9d4c9c4 OK 2025/05/16 02:24:56 INFO : nested/sub dir/file: Copied (new) 2025/05/16 02:24:56 INFO : nested/sub dir/file: Deleted 2025/05/16 02:24:56 DEBUG : sub dir/hello world: md5 = 8b3482c4e163bdb63eb2af135bf95f0e OK 2025/05/16 02:24:56 INFO : sub dir/hello world: Copied (new) 2025/05/16 02:24:56 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (26.24s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:25:17 DEBUG : existing: Need to transfer - File not found at Destination 2025/05/16 02:25:17 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/05/16 02:25:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:25:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:25:22 DEBUG : existing: md5 = 6e2b8c8d39ed0f6bbee4c365a7fefb86 OK 2025/05/16 02:25:22 INFO : existing: Copied (new) 2025/05/16 02:25:22 INFO : existing: Deleted 2025/05/16 02:25:23 DEBUG : existing-b: md5 = 3ecaf415d31ba01c8799addfad28c710 OK 2025/05/16 02:25:23 INFO : existing-b: Copied (new) 2025/05/16 02:25:23 INFO : existing-b: Deleted 2025/05/16 02:25:33 DEBUG : existing: Destination exists, skipping 2025/05/16 02:25:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:25:33 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/05/16 02:25:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:25:33 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (26.98s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:25:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xularuj8nege" 2025/05/16 02:25:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xularuj8nege.bin" 2025/05/16 02:25:44 DEBUG : Swift container crypt path rclone-test-xularuj8nege.bin: Auto set use_segments_container to true 2025/05/16 02:25:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xularuj8nege" 2025/05/16 02:25:50 DEBUG : Swift container crypt path rclone-test-xularuj8nege: Auto set use_segments_container to true 2025/05/16 02:25:55 DEBUG : potato2: md5 = f370b2891b8c86bd91323b2db9765596 OK 2025/05/16 02:26:00 DEBUG : empty space: md5 = fe0fa40cfd5bfb8050130285ae2d529a OK 2025/05/16 02:26:06 DEBUG : potato3: md5 = 3e494c6982df38a5a43695f0f9b48f05 OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi' -> Encrypted drive 'TestCryptSwift:rclone-test-xularuj8nege' 2025/05/16 02:26:16 DEBUG : empty space: md5 = 94a6eb81cb508166b80915788d9d525d OK 2025/05/16 02:26:22 DEBUG : potato3: md5 = 176ae895b2b6d28c1095e9e52fa55704 OK 2025/05/16 02:26:27 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:26:27 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/16 02:26:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xularuj8nege': Waiting for checks to finish 2025/05/16 02:26:33 INFO : potato2: Copied (server-side copy) 2025/05/16 02:26:33 INFO : potato2: Deleted 2025/05/16 02:26:37 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:26:37 DEBUG : empty space: Unchanged skipping 2025/05/16 02:26:42 INFO : empty space: Deleted 2025/05/16 02:26:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xularuj8nege': Waiting for transfers to finish 2025/05/16 02:26:43 INFO : potato3: Copied (server-side copy) 2025/05/16 02:26:48 INFO : potato3: Deleted 2025/05/16 02:26:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-topakib1dowa" 2025/05/16 02:26:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-topakib1dowa.bin" 2025/05/16 02:26:59 DEBUG : Swift container crypt path rclone-test-topakib1dowa.bin: Auto set use_segments_container to true 2025/05/16 02:27:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-topakib1dowa" 2025/05/16 02:27:04 DEBUG : Swift container crypt path rclone-test-topakib1dowa: Auto set use_segments_container to true 2025/05/16 02:27:10 DEBUG : empty space: Need to transfer - File not found at Destination 2025/05/16 02:27:10 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:27:10 DEBUG : potato3: Need to transfer - File not found at Destination 2025/05/16 02:27:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-topakib1dowa': Waiting for checks to finish 2025/05/16 02:27:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-topakib1dowa': Waiting for transfers to finish 2025/05/16 02:27:15 INFO : potato2: Copied (server-side copy) 2025/05/16 02:27:16 INFO : potato2: Deleted 2025/05/16 02:27:20 INFO : empty space: Copied (server-side copy) 2025/05/16 02:27:21 INFO : potato3: Copied (server-side copy) 2025/05/16 02:27:25 INFO : empty space: Deleted 2025/05/16 02:27:26 INFO : potato3: Deleted 2025/05/16 02:27:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-topakib1dowa': Purge remote 2025/05/16 02:27:31 DEBUG : Waiting for deletions to finish 2025/05/16 02:27:32 INFO : potato2.bin: Deleted 2025/05/16 02:27:32 INFO : potato3.bin: Deleted 2025/05/16 02:27:36 INFO : empty space.bin: Deleted 2025/05/16 02:27:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xularuj8nege': Purge remote 2025/05/16 02:27:36 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (113.19s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:27:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-lavuxah9cazu" 2025/05/16 02:27:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-lavuxah9cazu.bin" 2025/05/16 02:27:37 DEBUG : Swift container crypt path rclone-test-lavuxah9cazu.bin: Auto set use_segments_container to true 2025/05/16 02:27:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-lavuxah9cazu" 2025/05/16 02:27:43 DEBUG : Swift container crypt path rclone-test-lavuxah9cazu: Auto set use_segments_container to true 2025/05/16 02:27:49 DEBUG : potato2: md5 = 58268136c73668c2c48deb1fb56657e3 OK 2025/05/16 02:27:54 DEBUG : empty space: md5 = bdaa92b5ce7372023872e90a450a90f3 OK 2025/05/16 02:27:59 DEBUG : potato3: md5 = 56720a47e10d1b116236c4976a8ce13b OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi' -> Encrypted drive 'TestCryptSwift:rclone-test-lavuxah9cazu' 2025/05/16 02:28:04 DEBUG : empty space: md5 = 5d82f6292e2db44677f9d93d8cf0bbb4 OK 2025/05/16 02:28:05 DEBUG : potato3: md5 = b4d5b994cec0a8f32f6d8ecc761b7a50 OK 2025/05/16 02:28:05 DEBUG : empty space: Excluded (Size Filter) 2025/05/16 02:28:05 DEBUG : empty space: Excluded 2025/05/16 02:28:05 DEBUG : empty space: Excluded (Size Filter) 2025/05/16 02:28:05 DEBUG : empty space: Excluded 2025/05/16 02:28:05 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:28:05 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/16 02:28:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-lavuxah9cazu': Waiting for checks to finish 2025/05/16 02:28:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-lavuxah9cazu': Waiting for transfers to finish 2025/05/16 02:28:15 INFO : potato2: Copied (server-side copy) 2025/05/16 02:28:16 INFO : potato2: Deleted 2025/05/16 02:28:16 INFO : potato3: Copied (server-side copy) 2025/05/16 02:28:21 INFO : potato3: Deleted 2025/05/16 02:28:31 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qewixij5ciso" 2025/05/16 02:28:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qewixij5ciso.bin" 2025/05/16 02:28:31 DEBUG : Swift container crypt path rclone-test-qewixij5ciso.bin: Auto set use_segments_container to true 2025/05/16 02:28:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qewixij5ciso" 2025/05/16 02:28:37 DEBUG : Swift container crypt path rclone-test-qewixij5ciso: Auto set use_segments_container to true 2025/05/16 02:28:43 DEBUG : empty space: Excluded (Size Filter) 2025/05/16 02:28:43 DEBUG : empty space: Excluded 2025/05/16 02:28:43 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:28:43 DEBUG : potato3: Need to transfer - File not found at Destination 2025/05/16 02:28:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qewixij5ciso': Waiting for checks to finish 2025/05/16 02:28:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qewixij5ciso': Waiting for transfers to finish 2025/05/16 02:28:48 INFO : potato2: Copied (server-side copy) 2025/05/16 02:28:53 INFO : potato2: Deleted 2025/05/16 02:28:58 INFO : potato3: Copied (server-side copy) 2025/05/16 02:28:58 INFO : potato3: Deleted 2025/05/16 02:28:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qewixij5ciso': Purge remote 2025/05/16 02:28:59 DEBUG : Waiting for deletions to finish 2025/05/16 02:28:59 INFO : potato2.bin: Deleted 2025/05/16 02:29:04 INFO : potato3.bin: Deleted 2025/05/16 02:29:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-lavuxah9cazu': Purge remote 2025/05/16 02:29:04 DEBUG : Waiting for deletions to finish 2025/05/16 02:29:04 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (92.74s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:29:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-pogecad7rupu" 2025/05/16 02:29:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pogecad7rupu.bin" 2025/05/16 02:29:10 DEBUG : Swift container crypt path rclone-test-pogecad7rupu.bin: Auto set use_segments_container to true 2025/05/16 02:29:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pogecad7rupu" 2025/05/16 02:29:16 DEBUG : Swift container crypt path rclone-test-pogecad7rupu: Auto set use_segments_container to true 2025/05/16 02:29:21 DEBUG : potato2: md5 = 3ae711ded76d7faef8a41a1500173858 OK 2025/05/16 02:29:27 DEBUG : empty space: md5 = 3be39ca3fea0046c6460b55e6bbbcfd9 OK 2025/05/16 02:29:32 DEBUG : potato3: md5 = f815999d79b5edcd85c46f4ac1a170cd OK 2025/05/16 02:29:32 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi' -> Encrypted drive 'TestCryptSwift:rclone-test-pogecad7rupu' 2025/05/16 02:29:42 DEBUG : empty space: md5 = 44ebf06b4e156a6232db22acd03b0a98 OK 2025/05/16 02:29:48 DEBUG : potato3: md5 = 057aefa9d7857988d119acbb9ecb66a7 OK 2025/05/16 02:29:48 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:29:48 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/05/16 02:29:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pogecad7rupu': Waiting for checks to finish 2025/05/16 02:29:54 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:29:54 DEBUG : empty space: Unchanged skipping 2025/05/16 02:29:54 INFO : potato2: Copied (server-side copy) 2025/05/16 02:29:54 INFO : potato2: Deleted 2025/05/16 02:29:59 INFO : empty space: Deleted 2025/05/16 02:29:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pogecad7rupu': Waiting for transfers to finish 2025/05/16 02:30:04 INFO : potato3: Copied (server-side copy) 2025/05/16 02:30:09 INFO : potato3: Deleted 2025/05/16 02:30:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-fovuqoc3jehi" 2025/05/16 02:30:15 DEBUG : Config file has changed externally - reloading 2025/05/16 02:30:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fovuqoc3jehi.bin" 2025/05/16 02:30:15 DEBUG : Swift container crypt path rclone-test-fovuqoc3jehi.bin: Auto set use_segments_container to true 2025/05/16 02:30:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fovuqoc3jehi" 2025/05/16 02:30:21 DEBUG : Swift container crypt path rclone-test-fovuqoc3jehi: Auto set use_segments_container to true 2025/05/16 02:30:26 INFO : tomatoDir: Making directory 2025/05/16 02:30:26 DEBUG : empty space: Need to transfer - File not found at Destination 2025/05/16 02:30:26 DEBUG : potato2: Need to transfer - File not found at Destination 2025/05/16 02:30:26 DEBUG : potato3: Need to transfer - File not found at Destination 2025/05/16 02:30:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fovuqoc3jehi': Waiting for checks to finish 2025/05/16 02:30:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fovuqoc3jehi': Waiting for transfers to finish 2025/05/16 02:30:32 INFO : potato3: Copied (server-side copy) 2025/05/16 02:30:32 INFO : empty space: Copied (server-side copy) 2025/05/16 02:30:32 INFO : empty space: Deleted 2025/05/16 02:30:37 INFO : potato3: Deleted 2025/05/16 02:30:42 INFO : potato2: Copied (server-side copy) 2025/05/16 02:30:42 INFO : potato2: Deleted 2025/05/16 02:30:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fovuqoc3jehi': Purge remote 2025/05/16 02:30:43 DEBUG : Waiting for deletions to finish 2025/05/16 02:30:43 INFO : potato3.bin: Deleted 2025/05/16 02:30:43 INFO : empty space.bin: Deleted 2025/05/16 02:30:48 INFO : potato2.bin: Deleted 2025/05/16 02:30:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pogecad7rupu': Purge remote 2025/05/16 02:30:48 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (98.49s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:30:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/rclone-move-test" 2025/05/16 02:30:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-move-test.bin" 2025/05/16 02:30:49 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-move-test.bin: Auto set use_segments_container to true 2025/05/16 02:30:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-move-test" 2025/05/16 02:30:54 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-move-test: Auto set use_segments_container to true 2025/05/16 02:31:00 DEBUG : potato2: md5 = c671a5ff26b96d4e697d0ef7c75d785f OK --- PASS: TestServerSideMoveOverlap (12.28s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:31:00 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test" 2025/05/16 02:31:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-sync-test.bin" 2025/05/16 02:31:01 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-sync-test.bin: Auto set use_segments_container to true 2025/05/16 02:31:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-sync-test" 2025/05/16 02:31:07 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncOverlap (12.49s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:31:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test" 2025/05/16 02:31:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-sync-test.bin" 2025/05/16 02:31:13 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-sync-test.bin: Auto set use_segments_container to true 2025/05/16 02:31:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-sync-test" 2025/05/16 02:31:19 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-sync-test: Auto set use_segments_container to true 2025/05/16 02:31:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test-include/layer2" 2025/05/16 02:31:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-sync-test-include/layer2.bin" 2025/05/16 02:31:24 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/05/16 02:31:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-sync-test-include/layer2" 2025/05/16 02:31:30 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/05/16 02:31:36 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test-ignore-file" 2025/05/16 02:31:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-sync-test-ignore-file.bin" 2025/05/16 02:31:36 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/05/16 02:31:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/rclone-sync-test-ignore-file" 2025/05/16 02:31:42 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/05/16 02:31:53 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = aa254cc7e3c6bd978fc4159ea1a8ec43 OK 2025/05/16 02:31:58 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/05/16 02:31:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test': Waiting for checks to finish 2025/05/16 02:31:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test': Waiting for transfers to finish 2025/05/16 02:31:58 DEBUG : Waiting for deletions to finish 2025/05/16 02:31:58 INFO : There was nothing to transfer 2025/05/16 02:32:08 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/05/16 02:32:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:32:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:32:08 DEBUG : Waiting for deletions to finish 2025/05/16 02:32:08 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:32:19 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/05/16 02:32:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/05/16 02:32:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/05/16 02:32:19 DEBUG : Waiting for deletions to finish 2025/05/16 02:32:19 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:32:24 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/05/16 02:32:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:32:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:32:24 DEBUG : Waiting for deletions to finish 2025/05/16 02:32:24 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:32:24 DEBUG : : Excluded 2025/05/16 02:32:24 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/05/16 02:32:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/05/16 02:32:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/05/16 02:32:24 DEBUG : Waiting for deletions to finish 2025/05/16 02:32:24 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (84.78s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:32:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/dst" 2025/05/16 02:32:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst.bin" 2025/05/16 02:32:38 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst.bin: Auto set use_segments_container to true 2025/05/16 02:32:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst" 2025/05/16 02:32:44 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst: Auto set use_segments_container to true 2025/05/16 02:32:49 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/CompareDest" 2025/05/16 02:32:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/CompareDest.bin" 2025/05/16 02:32:50 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/CompareDest.bin: Auto set use_segments_container to true 2025/05/16 02:32:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/CompareDest" 2025/05/16 02:32:55 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/CompareDest: Auto set use_segments_container to true 2025/05/16 02:33:06 DEBUG : one: Need to transfer - File not found at Destination 2025/05/16 02:33:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:33:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:33:06 DEBUG : one: md5 = 24451d9ec8e3a8882d8245eef9cb7e59 OK 2025/05/16 02:33:06 INFO : one: Copied (new) 2025/05/16 02:33:06 DEBUG : Waiting for deletions to finish 2025/05/16 02:33:07 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/16 02:33:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:33:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:33:12 DEBUG : one: md5 = e469d6f22d72c17d6493e1dfbfba7850 OK 2025/05/16 02:33:12 INFO : one: Copied (replaced existing) 2025/05/16 02:33:12 DEBUG : Waiting for deletions to finish 2025/05/16 02:33:12 DEBUG : dst/one: md5 = e266c06ae7ea28f57dd8d7b7b4e50d76 OK 2025/05/16 02:33:13 DEBUG : CompareDest/one: md5 = 6d0541001d48b8bf6d242e41faa921d4 OK 2025/05/16 02:33:13 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/16 02:33:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:33:13 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:33:13 DEBUG : one: Destination found in --compare-dest, skipping 2025/05/16 02:33:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:33:13 DEBUG : Waiting for deletions to finish 2025/05/16 02:33:13 INFO : There was nothing to transfer 2025/05/16 02:33:19 DEBUG : CompareDest/two: md5 = 9787f7ce922f4cc80f817e0bced6b421 OK 2025/05/16 02:33:20 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/16 02:33:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:33:20 DEBUG : two: Destination found in --compare-dest, skipping 2025/05/16 02:33:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:33:20 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:33:20 DEBUG : one: Destination found in --compare-dest, skipping 2025/05/16 02:33:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:33:20 DEBUG : Waiting for deletions to finish 2025/05/16 02:33:20 INFO : There was nothing to transfer 2025/05/16 02:33:20 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/16 02:33:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:33:20 DEBUG : two: Destination found in --compare-dest, skipping 2025/05/16 02:33:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:33:20 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:33:20 DEBUG : one: Destination found in --compare-dest, skipping 2025/05/16 02:33:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:33:20 DEBUG : Waiting for deletions to finish 2025/05/16 02:33:20 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2025/05/16 02:33:26 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/16 02:33:26 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/05/16 02:33:26 DEBUG : two: Need to transfer - File not found at Destination 2025/05/16 02:33:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:33:26 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:33:26 DEBUG : one: Destination found in --compare-dest, skipping 2025/05/16 02:33:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:33:31 DEBUG : two: md5 = 6cd1b27069493ea243f11cb00ac658e5 OK 2025/05/16 02:33:31 INFO : two: Copied (new) 2025/05/16 02:33:31 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (82.73s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:34:06 DEBUG : pre-dest1/1: md5 = c577102d7173d5f9f70e775efbd55feb OK 2025/05/16 02:34:06 DEBUG : pre-dest2/2: md5 = 51ae54bc0f05a060721ff61f74f2c912 OK 2025/05/16 02:34:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/dest" 2025/05/16 02:34:11 DEBUG : Config file has changed externally - reloading 2025/05/16 02:34:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dest.bin" 2025/05/16 02:34:12 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dest.bin: Auto set use_segments_container to true 2025/05/16 02:34:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dest" 2025/05/16 02:34:32 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dest: Auto set use_segments_container to true 2025/05/16 02:34:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/pre-dest1" 2025/05/16 02:34:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/pre-dest1.bin" 2025/05/16 02:34:38 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/pre-dest1.bin: Auto set use_segments_container to true 2025/05/16 02:34:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/pre-dest1" 2025/05/16 02:34:59 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/pre-dest1: Auto set use_segments_container to true 2025/05/16 02:35:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/pre-dest2" 2025/05/16 02:35:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/pre-dest2.bin" 2025/05/16 02:35:04 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/pre-dest2.bin: Auto set use_segments_container to true 2025/05/16 02:35:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/pre-dest2" 2025/05/16 02:35:10 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/pre-dest2: Auto set use_segments_container to true 2025/05/16 02:35:21 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:35:21 DEBUG : 1: Destination found in --compare-dest, skipping 2025/05/16 02:35:26 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:35:26 DEBUG : 2: Destination found in --compare-dest, skipping 2025/05/16 02:35:36 DEBUG : 3: Need to transfer - File not found at Destination 2025/05/16 02:35:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dest': Waiting for checks to finish 2025/05/16 02:35:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dest': Waiting for transfers to finish 2025/05/16 02:35:42 DEBUG : 3: md5 = 329940b76289f517bb2df59aeee96a7d OK 2025/05/16 02:35:42 INFO : 3: Copied (new) 2025/05/16 02:35:42 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (117.22s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:35:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/dst" 2025/05/16 02:35:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst.bin" 2025/05/16 02:35:58 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst.bin: Auto set use_segments_container to true 2025/05/16 02:36:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst" 2025/05/16 02:36:04 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst: Auto set use_segments_container to true 2025/05/16 02:36:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/CopyDest" 2025/05/16 02:36:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/CopyDest.bin" 2025/05/16 02:36:09 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/CopyDest.bin: Auto set use_segments_container to true 2025/05/16 02:36:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/CopyDest" 2025/05/16 02:36:15 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/CopyDest: Auto set use_segments_container to true 2025/05/16 02:36:30 DEBUG : one: Need to transfer - File not found at Destination 2025/05/16 02:36:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:36:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:36:31 DEBUG : one: md5 = 1f90a786aba311f6d497b03f6c22e2ea OK 2025/05/16 02:36:31 INFO : one: Copied (new) 2025/05/16 02:36:31 DEBUG : Waiting for deletions to finish 2025/05/16 02:36:31 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/16 02:36:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:36:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:36:37 DEBUG : one: md5 = 0bd1de787ef0f5e6ecea6d6d10b6d3d9 OK 2025/05/16 02:36:37 INFO : one: Copied (replaced existing) 2025/05/16 02:36:37 DEBUG : Waiting for deletions to finish 2025/05/16 02:36:37 DEBUG : dst/one: md5 = dba847a23a8cd78bb89061ecb50d2235 OK 2025/05/16 02:36:42 DEBUG : CopyDest/one: md5 = 22a7c43fac580198dd16153b32cb5157 OK 2025/05/16 02:36:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/BackupDir" 2025/05/16 02:36:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/BackupDir.bin" 2025/05/16 02:36:43 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/BackupDir.bin: Auto set use_segments_container to true 2025/05/16 02:36:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/BackupDir" 2025/05/16 02:36:49 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/BackupDir: Auto set use_segments_container to true 2025/05/16 02:36:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:36:54 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/16 02:36:59 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:36:59 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/05/16 02:37:15 INFO : one: Copied (server-side copy) 2025/05/16 02:37:15 INFO : one: Deleted 2025/05/16 02:37:21 INFO : one: Copied (server-side copy) 2025/05/16 02:37:21 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/05/16 02:37:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:37:21 DEBUG : Waiting for deletions to finish 2025/05/16 02:37:33 DEBUG : CopyDest/two: md5 = 8fae1369ca0f6363b03b4cdb865d52e2 OK 2025/05/16 02:37:34 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:37:34 DEBUG : one: Unchanged skipping 2025/05/16 02:37:34 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:37:49 INFO : two: Copied (server-side copy) 2025/05/16 02:37:49 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/05/16 02:37:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:37:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:37:49 DEBUG : Waiting for deletions to finish 2025/05/16 02:37:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:37:59 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:37:59 DEBUG : one: Unchanged skipping 2025/05/16 02:38:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:38:00 DEBUG : two: Unchanged skipping 2025/05/16 02:38:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:38:00 DEBUG : Waiting for deletions to finish 2025/05/16 02:38:00 INFO : There was nothing to transfer 2025/05/16 02:38:05 DEBUG : CopyDest/three: md5 = 119b0289bfa1acb914e91b4f1851ac8c OK 2025/05/16 02:38:16 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:38:16 DEBUG : one: Unchanged skipping 2025/05/16 02:38:16 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/05/16 02:38:16 DEBUG : three: Destination not found in --copy-dest 2025/05/16 02:38:16 DEBUG : three: Need to transfer - File not found at Destination 2025/05/16 02:38:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:38:16 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:38:16 DEBUG : two: Unchanged skipping 2025/05/16 02:38:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:38:16 DEBUG : three: md5 = ac146dc08aba1d8cf0bd6ecc3842f4a7 OK 2025/05/16 02:38:16 INFO : three: Copied (new) 2025/05/16 02:38:16 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (155.81s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:38:34 DEBUG : dst/one: md5 = e89645182d54e7af46a08018cbeb0c36 OK 2025/05/16 02:38:39 DEBUG : dst/two: md5 = e5a87a2aa835bf556d48a1c21650d87c OK 2025/05/16 02:38:39 DEBUG : dst/three.txt: md5 = 59962a484c347691a04cc431f8fffe2e OK 2025/05/16 02:38:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/dst" 2025/05/16 02:38:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst.bin" 2025/05/16 02:38:45 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst.bin: Auto set use_segments_container to true 2025/05/16 02:38:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst" 2025/05/16 02:38:50 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst: Auto set use_segments_container to true 2025/05/16 02:38:56 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/backup" 2025/05/16 02:38:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/backup.bin" 2025/05/16 02:38:56 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/backup.bin: Auto set use_segments_container to true 2025/05/16 02:39:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/backup" 2025/05/16 02:39:02 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/backup: Auto set use_segments_container to true 2025/05/16 02:39:07 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 02:39:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:39:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:39:07 DEBUG : two: Unchanged skipping 2025/05/16 02:39:18 INFO : one: Copied (server-side copy) 2025/05/16 02:39:18 INFO : one: Deleted 2025/05/16 02:39:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:39:18 DEBUG : one: md5 = 06a5d9df66c85b12a47ac78f9d3e6422 OK 2025/05/16 02:39:18 INFO : one: Copied (new) 2025/05/16 02:39:18 DEBUG : Waiting for deletions to finish 2025/05/16 02:39:29 INFO : three.txt: Copied (server-side copy) 2025/05/16 02:39:29 INFO : three.txt: Deleted 2025/05/16 02:39:29 INFO : three.txt: Moved into backup dir 2025/05/16 02:39:30 DEBUG : dst/three.txt: md5 = 06254adfe3a53c773f0fb78e26a9b9ca OK 2025/05/16 02:39:30 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/05/16 02:39:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:39:30 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:39:30 DEBUG : two: Unchanged skipping 2025/05/16 02:39:36 INFO : one: Copied (server-side copy) 2025/05/16 02:39:36 INFO : one: Deleted 2025/05/16 02:39:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:39:36 DEBUG : one: md5 = eee4c6b9092a6b13a5263f5d001575f2 OK 2025/05/16 02:39:36 INFO : one: Copied (new) 2025/05/16 02:39:36 DEBUG : Waiting for deletions to finish 2025/05/16 02:39:41 INFO : three.txt: Copied (server-side copy) 2025/05/16 02:39:41 INFO : three.txt: Deleted 2025/05/16 02:39:41 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (79.09s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:39:53 DEBUG : dst/one: md5 = bacbd79831e2519cae2c19cb19e25b7c OK 2025/05/16 02:39:58 DEBUG : dst/two: md5 = 386b3597e9d6597bed8043beabc60ed2 OK 2025/05/16 02:39:58 DEBUG : dst/three.txt: md5 = 9b1534dd3579b4b82b1753e23544f8d6 OK 2025/05/16 02:39:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/dst" 2025/05/16 02:39:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst.bin" 2025/05/16 02:39:59 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst.bin: Auto set use_segments_container to true 2025/05/16 02:40:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst" 2025/05/16 02:40:05 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst: Auto set use_segments_container to true 2025/05/16 02:40:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/backup" 2025/05/16 02:40:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/backup.bin" 2025/05/16 02:40:10 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/backup.bin: Auto set use_segments_container to true 2025/05/16 02:40:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/backup" 2025/05/16 02:40:16 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/backup: Auto set use_segments_container to true 2025/05/16 02:40:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 02:40:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:40:26 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:40:26 DEBUG : two: Unchanged skipping 2025/05/16 02:40:32 INFO : one: Copied (server-side copy) to: one.bak 2025/05/16 02:40:32 INFO : one: Deleted 2025/05/16 02:40:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:40:32 DEBUG : one: md5 = aede492a12a3c512a27157d7bcbe714f OK 2025/05/16 02:40:32 INFO : one: Copied (new) 2025/05/16 02:40:32 DEBUG : Waiting for deletions to finish 2025/05/16 02:40:49 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/05/16 02:40:49 INFO : three.txt: Deleted 2025/05/16 02:40:49 INFO : three.txt: Moved into backup dir 2025/05/16 02:40:54 DEBUG : dst/three.txt: md5 = c91e431be5ef97380f993f8d506b28b6 OK 2025/05/16 02:40:55 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/05/16 02:40:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:40:55 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:40:55 DEBUG : two: Unchanged skipping 2025/05/16 02:41:00 INFO : one: Copied (server-side copy) to: one.bak 2025/05/16 02:41:01 INFO : one: Deleted 2025/05/16 02:41:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:41:01 DEBUG : one: md5 = edcbcb75359b61bf6cd4afa593647e13 OK 2025/05/16 02:41:01 INFO : one: Copied (new) 2025/05/16 02:41:01 DEBUG : Waiting for deletions to finish 2025/05/16 02:41:21 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/05/16 02:41:22 INFO : three.txt: Deleted 2025/05/16 02:41:22 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (115.44s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:41:48 DEBUG : dst/one: md5 = c99900bd412ff43b986ec31cc7821d6f OK 2025/05/16 02:41:53 DEBUG : dst/two: md5 = 9a454a7aa0fb36caf3efe562181a7bb4 OK 2025/05/16 02:41:54 DEBUG : dst/three.txt: md5 = d5eacf6aac5eac6fe987f393d9df4e39 OK 2025/05/16 02:41:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/dst" 2025/05/16 02:41:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst.bin" 2025/05/16 02:41:54 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst.bin: Auto set use_segments_container to true 2025/05/16 02:42:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst" 2025/05/16 02:42:00 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst: Auto set use_segments_container to true 2025/05/16 02:42:05 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/backup" 2025/05/16 02:42:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/backup.bin" 2025/05/16 02:42:06 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/backup.bin: Auto set use_segments_container to true 2025/05/16 02:42:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/backup" 2025/05/16 02:42:11 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/backup: Auto set use_segments_container to true 2025/05/16 02:42:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 02:42:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:42:17 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:42:17 DEBUG : two: Unchanged skipping 2025/05/16 02:42:27 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/05/16 02:42:27 INFO : one: Deleted 2025/05/16 02:42:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:42:28 DEBUG : one: md5 = d78843db2f601f76b8c9f097846b6bc3 OK 2025/05/16 02:42:28 INFO : one: Copied (new) 2025/05/16 02:42:28 DEBUG : Waiting for deletions to finish 2025/05/16 02:42:44 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/05/16 02:42:44 INFO : three.txt: Deleted 2025/05/16 02:42:44 INFO : three.txt: Moved into backup dir 2025/05/16 02:42:44 DEBUG : dst/three.txt: md5 = ae16447ec90e497ceb48e9cea59f1d89 OK 2025/05/16 02:42:50 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/05/16 02:42:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:42:55 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:42:55 DEBUG : two: Unchanged skipping 2025/05/16 02:42:55 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/05/16 02:42:55 INFO : one: Deleted 2025/05/16 02:42:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:42:56 DEBUG : one: md5 = ce71934e4797626cd0b6843a6ca947fc OK 2025/05/16 02:42:56 INFO : one: Copied (new) 2025/05/16 02:42:56 DEBUG : Waiting for deletions to finish 2025/05/16 02:43:06 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/05/16 02:43:06 INFO : three.txt: Deleted 2025/05/16 02:43:06 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (94.41s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:43:23 DEBUG : dst/one: md5 = 0c370850adc8f4d3e9b7855e3f899932 OK 2025/05/16 02:43:28 DEBUG : dst/two: md5 = 630025b79a16eae56a97ade7d9155d7b OK 2025/05/16 02:43:28 DEBUG : dst/three.txt: md5 = c1a0b521c76bc614f26fcbfadb9e5401 OK 2025/05/16 02:43:28 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/dst" 2025/05/16 02:43:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst.bin" 2025/05/16 02:43:29 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst.bin: Auto set use_segments_container to true 2025/05/16 02:43:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst" 2025/05/16 02:43:34 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst: Auto set use_segments_container to true 2025/05/16 02:43:39 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 02:43:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:43:45 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:43:45 DEBUG : two: Unchanged skipping 2025/05/16 02:43:50 INFO : one: Copied (server-side copy) to: one.bak 2025/05/16 02:43:50 INFO : one: Deleted 2025/05/16 02:43:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:43:50 DEBUG : one: md5 = 5753922b7cc2f9e983f59d5a2f0b9de3 OK 2025/05/16 02:43:50 INFO : one: Copied (new) 2025/05/16 02:43:50 DEBUG : Waiting for deletions to finish 2025/05/16 02:44:06 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/05/16 02:44:06 INFO : three.txt: Deleted 2025/05/16 02:44:06 INFO : three.txt: Moved into backup dir 2025/05/16 02:44:17 DEBUG : dst/three.txt: md5 = 88c280179df86894c11cdf80cb8ef1a2 OK 2025/05/16 02:44:22 DEBUG : one.bak: Excluded (Path Filter) 2025/05/16 02:44:22 DEBUG : one.bak: Excluded 2025/05/16 02:44:22 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/05/16 02:44:22 DEBUG : three.txt.bak: Excluded 2025/05/16 02:44:22 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/05/16 02:44:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for checks to finish 2025/05/16 02:44:27 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:44:27 DEBUG : two: Unchanged skipping 2025/05/16 02:44:27 INFO : one: Copied (server-side copy) to: one.bak 2025/05/16 02:44:28 INFO : one: Deleted 2025/05/16 02:44:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi/dst': Waiting for transfers to finish 2025/05/16 02:44:28 DEBUG : one: md5 = fa54f970377a6251fda0348d91b62730 OK 2025/05/16 02:44:28 INFO : one: Copied (new) 2025/05/16 02:44:28 DEBUG : Waiting for deletions to finish 2025/05/16 02:44:38 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/05/16 02:44:39 INFO : three.txt: Deleted 2025/05/16 02:44:39 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (92.85s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:44:55 DEBUG : dst/one: md5 = b86a9ee9aede6bb4b5e3be10791a3b6e OK 2025/05/16 02:45:01 DEBUG : dst/two: md5 = f318cbb2edccd7b0d3289b4202c22532 OK 2025/05/16 02:45:01 DEBUG : dst/three.txt: md5 = 0b6dd3349ff3644eb03dd4b0e25f124b OK 2025/05/16 02:45:01 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/dst" 2025/05/16 02:45:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst.bin" 2025/05/16 02:45:02 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst.bin: Auto set use_segments_container to true 2025/05/16 02:45:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst" 2025/05/16 02:45:07 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst: Auto set use_segments_container to true 2025/05/16 02:45:13 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 02:45:23 INFO : one: Copied (server-side copy) to: one.bak 2025/05/16 02:45:23 INFO : one: Deleted 2025/05/16 02:45:24 DEBUG : one: md5 = 108fc2766f51b9dda291a261384e0de0 OK 2025/05/16 02:45:24 INFO : one: Copied (new) 2025/05/16 02:45:24 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:45:24 DEBUG : two: Unchanged skipping 2025/05/16 02:45:24 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/05/16 02:45:39 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/05/16 02:45:39 INFO : three.txt: Deleted 2025/05/16 02:45:39 DEBUG : three.txt: md5 = c72be4d97ec0ddfe8b35f2a83cbf564c OK 2025/05/16 02:45:39 INFO : three.txt: Copied (new) 2025/05/16 02:45:50 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/05/16 02:45:56 INFO : one: Copied (server-side copy) to: one.bak 2025/05/16 02:45:56 INFO : one: Deleted 2025/05/16 02:45:56 DEBUG : one: md5 = 6727d129b95bd302b5dc7401cc2fcef5 OK 2025/05/16 02:45:56 INFO : one: Copied (new) 2025/05/16 02:46:01 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:46:01 DEBUG : two: Unchanged skipping 2025/05/16 02:46:01 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/05/16 02:46:16 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/05/16 02:46:16 INFO : three.txt: Deleted 2025/05/16 02:46:17 DEBUG : three.txt: md5 = d84298b7b1d676296cc0fcde018c1f7a OK 2025/05/16 02:46:17 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (102.90s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:46:38 DEBUG : dst/one: md5 = 2a2cb271a68b6f62082216681c57bf29 OK 2025/05/16 02:46:43 DEBUG : dst/two: md5 = c9da0c9b7a47637724f0b01a28802f11 OK 2025/05/16 02:46:44 DEBUG : dst/three.txt: md5 = e1465f05fe542c440ea4db11c3f39287 OK 2025/05/16 02:46:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zugatar4beqi/dst" 2025/05/16 02:46:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst.bin" 2025/05/16 02:46:44 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst.bin: Auto set use_segments_container to true 2025/05/16 02:46:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zugatar4beqi/dst" 2025/05/16 02:46:50 DEBUG : Swift container crypt path rclone-test-zugatar4beqi/dst: Auto set use_segments_container to true 2025/05/16 02:46:55 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/05/16 02:47:06 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/05/16 02:47:06 INFO : one: Deleted 2025/05/16 02:47:06 DEBUG : one: md5 = d9a39ceb541c79173683825e7b54617b OK 2025/05/16 02:47:06 INFO : one: Copied (new) 2025/05/16 02:47:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:47:06 DEBUG : two: Unchanged skipping 2025/05/16 02:47:06 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/05/16 02:47:27 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/05/16 02:47:27 INFO : three.txt: Deleted 2025/05/16 02:47:27 DEBUG : three.txt: md5 = f8aaa1d138329e5e5af2614308e0ecee OK 2025/05/16 02:47:27 INFO : three.txt: Copied (new) 2025/05/16 02:47:38 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/05/16 02:47:44 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/05/16 02:47:44 INFO : one: Deleted 2025/05/16 02:47:44 DEBUG : one: md5 = 607f68ae4630408f223dc73d32759c8d OK 2025/05/16 02:47:44 INFO : one: Copied (new) 2025/05/16 02:47:49 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:47:49 DEBUG : two: Unchanged skipping 2025/05/16 02:47:49 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/05/16 02:48:10 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/05/16 02:48:10 INFO : three.txt: Deleted 2025/05/16 02:48:10 DEBUG : three.txt: md5 = dc28b2df2f3a1569642a78f20d378417 OK 2025/05/16 02:48:10 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (113.08s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:48:32 DEBUG : Testêé: md5 = 5fb556f1cfa2c767c4cac88ae7c309bb OK 2025/05/16 02:48:32 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/05/16 02:48:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:48:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:48:32 DEBUG : Testêé: md5 = 0973e532e0231b9b77ec7b068308ca94 OK 2025/05/16 02:48:32 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/05/16 02:48:32 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (1.51s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:48:33 DEBUG : existing: Need to transfer - File not found at Destination 2025/05/16 02:48:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:48:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:48:38 DEBUG : existing: md5 = 6707b9133d636ecbc1d044f6febb668b OK 2025/05/16 02:48:38 INFO : existing: Copied (new) 2025/05/16 02:48:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:48:44 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/05/16 02:48:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:48:44 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/05/16 02:48:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:48:44 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': not deleting files as there were IO errors 2025/05/16 02:48:44 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncImmutable (16.95s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:48:50 DEBUG : EXISTING: md5 = 0d5a102311cdd4b86024fc273ed5d3af OK 2025/05/16 02:48:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:48:50 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:48:50 DEBUG : existing: Unchanged skipping 2025/05/16 02:48:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:48:50 DEBUG : Waiting for deletions to finish 2025/05/16 02:48:50 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.11s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.10s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", 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-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", 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-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.48s) --- SKIP: TestMaxTransfer/Hard (0.19s) --- SKIP: TestMaxTransfer/Soft (0.10s) --- SKIP: TestMaxTransfer/Cautious (0.19s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:48:52 DEBUG : both0: md5 = 5b807855e2c3479da51fbfa6e6b264dd OK 2025/05/16 02:48:53 DEBUG : only0: md5 = ebea10d2897969a7a6c35227e91d3040 OK 2025/05/16 02:48:58 DEBUG : both1: md5 = 2087804c0670accd37ef0e0e8528345a OK 2025/05/16 02:49:03 DEBUG : only1: md5 = 8550a87949f8754e667b36b3d0753d42 OK 2025/05/16 02:49:09 DEBUG : both2: md5 = 00b08a36c8ffc4e4439d5a0400dcb48b OK 2025/05/16 02:49:10 DEBUG : only2: md5 = 8b7e2a02106af96c45c928ec1c31a234 OK 2025/05/16 02:49:15 DEBUG : both3: md5 = 100b5610419dd0bca72daf8fc04068c4 OK 2025/05/16 02:49:20 DEBUG : only3: md5 = f198178c47e26a7d1c354e6d97428d0a OK 2025/05/16 02:49:21 DEBUG : both4: md5 = a1ba777a146ace9802b2eb8aef235ef3 OK 2025/05/16 02:49:21 DEBUG : only4: md5 = 41927ad0a621d8474636130dd2eed480 OK 2025/05/16 02:49:21 DEBUG : both5: md5 = 495c9faa04d803a8e27f8a5ab8472183 OK 2025/05/16 02:49:22 DEBUG : only5: md5 = 732cb6c5f3bee3be4ea510303f15f2ec OK 2025/05/16 02:49:27 DEBUG : both6: md5 = 3864806c199f657c50f4fde7107c0299 OK 2025/05/16 02:49:28 DEBUG : only6: md5 = 5d71a59e5f1bfbb712b46b8611123751 OK 2025/05/16 02:49:28 DEBUG : both7: md5 = 9a528bb5f509f64e049eda9f87d91da0 OK 2025/05/16 02:49:28 DEBUG : only7: md5 = 11c7e33d2b1561ece49e19219792d3db OK 2025/05/16 02:49:34 DEBUG : both8: md5 = 4bee90cb53c815ad4e8bf46325eda458 OK 2025/05/16 02:49:39 DEBUG : only8: md5 = 60d7c3128b392d6189e2c0a14b4ad229 OK 2025/05/16 02:49:39 DEBUG : both9: md5 = ea4c25cbd3d7d222e0c07c183e0e9e3f OK 2025/05/16 02:49:45 DEBUG : only9: md5 = 2e74d1db6cdcc6bc796e2a389ae0e93f OK 2025/05/16 02:49:50 DEBUG : both10: md5 = de7edb20ea6bb65f284f1e87259349bb OK 2025/05/16 02:49:55 DEBUG : only10: md5 = d5e2e0e55a27d138d3fce82cb363748a OK 2025/05/16 02:49:56 DEBUG : both11: md5 = afb62333eb254f85f5c46b9447df4f32 OK 2025/05/16 02:49:56 DEBUG : only11: md5 = f15d0888145f89020c4b62f1f77271fe OK 2025/05/16 02:50:02 DEBUG : both12: md5 = 15a92c4a8478c77482fd57c0da6bcca4 OK 2025/05/16 02:50:02 DEBUG : only12: md5 = f1709ad8f5b6cc7dcc18aeedebf912e1 OK 2025/05/16 02:50:03 DEBUG : both13: md5 = 1434bacb92fd2dd0fc9b1063440b0ad0 OK 2025/05/16 02:50:08 DEBUG : only13: md5 = ebfa90d51319b0b41b763822d1c5cf2c OK 2025/05/16 02:50:13 DEBUG : both14: md5 = c712ea6138fee32285b3e9fa832d4237 OK 2025/05/16 02:50:18 DEBUG : only14: md5 = fd0f48c26c245866339b852f3be21111 OK 2025/05/16 02:50:24 DEBUG : both15: md5 = 63f0d92dc034cbeb56770fbc644d387f OK 2025/05/16 02:50:24 DEBUG : only15: md5 = bac669239d12a110f69f81985b1e374b OK 2025/05/16 02:50:30 DEBUG : both16: md5 = c7ecf87d4a8c87ea2624660271c12b72 OK 2025/05/16 02:50:30 DEBUG : only16: md5 = b5cdc52b9568bfdbe4260d75bffa0532 OK 2025/05/16 02:50:35 DEBUG : both17: md5 = c4fdb0f03a05e52b044decdecee6613e OK 2025/05/16 02:50:40 DEBUG : only17: md5 = 9a02b1663c249b6793a7ccc08c8c156e OK 2025/05/16 02:50:46 DEBUG : both18: md5 = dbe272ed9c1367e621a48799ad83a9b8 OK 2025/05/16 02:50:46 DEBUG : only18: md5 = 87b125d5790570d5978ac1061ea0f8b0 OK 2025/05/16 02:50:51 DEBUG : both19: md5 = 50a4f3ae7db53509992fe92e1ec3ecbc OK 2025/05/16 02:50:57 DEBUG : only19: md5 = 650354372737765880fdec3c9fafade8 OK 2025/05/16 02:51:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:51:24 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both0: Unchanged skipping 2025/05/16 02:51:24 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both10: Unchanged skipping 2025/05/16 02:51:24 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both11: Unchanged skipping 2025/05/16 02:51:24 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both1: Unchanged skipping 2025/05/16 02:51:24 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both12: Unchanged skipping 2025/05/16 02:51:24 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both13: Unchanged skipping 2025/05/16 02:51:24 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both17: Unchanged skipping 2025/05/16 02:51:24 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both18: Unchanged skipping 2025/05/16 02:51:24 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both19: Unchanged skipping 2025/05/16 02:51:24 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:24 DEBUG : both2: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both14: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both15: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both16: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both4: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both5: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both6: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both7: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both8: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both9: Unchanged skipping 2025/05/16 02:51:29 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:51:29 DEBUG : both3: Unchanged skipping 2025/05/16 02:51:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:51:29 DEBUG : Waiting for deletions to finish 2025/05/16 02:51:29 INFO : only4: Deleted 2025/05/16 02:51:29 INFO : only6: Deleted 2025/05/16 02:51:29 INFO : only0: Deleted 2025/05/16 02:51:29 INFO : only18: Deleted 2025/05/16 02:51:29 INFO : only7: Deleted 2025/05/16 02:51:30 INFO : only11: Deleted 2025/05/16 02:51:34 INFO : only14: Deleted 2025/05/16 02:51:35 INFO : only17: Deleted 2025/05/16 02:51:35 INFO : only3: Deleted 2025/05/16 02:51:35 INFO : only2: Deleted 2025/05/16 02:51:35 INFO : only5: Deleted 2025/05/16 02:51:35 INFO : only15: Deleted 2025/05/16 02:51:36 INFO : only16: Deleted 2025/05/16 02:51:40 INFO : only13: Deleted 2025/05/16 02:51:40 INFO : only9: Deleted 2025/05/16 02:51:45 INFO : only1: Deleted 2025/05/16 02:51:45 INFO : only19: Deleted 2025/05/16 02:51:45 INFO : only12: Deleted 2025/05/16 02:51:46 INFO : only8: Deleted 2025/05/16 02:51:50 INFO : only10: Deleted 2025/05/16 02:51:50 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (278.10s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:53:30 DEBUG : both0: md5 = 6c6b97acd32d52893656403b92b3f89d OK 2025/05/16 02:53:30 DEBUG : only0: md5 = da21cdc5b030ab2ec75ef5318351f885 OK 2025/05/16 02:53:35 DEBUG : both1: md5 = 09438ace032198410eb8df9593463731 OK 2025/05/16 02:53:40 DEBUG : only1: md5 = 8274b31cdca9fd589f4bff674e54551a OK 2025/05/16 02:53:46 DEBUG : both2: md5 = 46bbdd10164cca539c69d44195999dd7 OK 2025/05/16 02:53:46 DEBUG : only2: md5 = 3857c216a751170abd7338d2e7185711 OK 2025/05/16 02:53:51 DEBUG : both3: md5 = 6afac1184abe30cad01c91c6a5d6c5ac OK 2025/05/16 02:53:57 DEBUG : only3: md5 = 17dfc2efa1bce2fad6a3603f67fd0c4a OK 2025/05/16 02:53:57 DEBUG : both4: md5 = 9d3748b205d8d6877aeacfa0f70b2925 OK 2025/05/16 02:53:57 DEBUG : only4: md5 = 547e39d4e7a2eb6ab3947c12b13d8838 OK 2025/05/16 02:53:57 DEBUG : both5: md5 = 51431e5f48c01447980908e5654b848f OK 2025/05/16 02:53:57 DEBUG : only5: md5 = e2175f161c552a7c61293049886b49cb OK 2025/05/16 02:54:02 DEBUG : both6: md5 = 7407c8f7cfcdedd798fe987cba0f6b39 OK 2025/05/16 02:54:03 DEBUG : only6: md5 = 42d6036d62a3dde58855ff392f1dce15 OK 2025/05/16 02:54:03 DEBUG : both7: md5 = ca1f7459c57cd5df06f4ed16e91d362f OK 2025/05/16 02:54:03 DEBUG : only7: md5 = 794a550b61b175ae3b0b60b8006a64e3 OK 2025/05/16 02:54:08 DEBUG : both8: md5 = d212a0ad06a6a8ea520f31abc235395c OK 2025/05/16 02:54:13 DEBUG : only8: md5 = 57b4f54158f2d3649f460e6062620cc8 OK 2025/05/16 02:54:13 DEBUG : both9: md5 = d137ea542c5a0fab00b06fdceb0d1d42 OK 2025/05/16 02:54:18 DEBUG : only9: md5 = 9f0384ee925b8fff2f6ec375e9603ca9 OK 2025/05/16 02:54:24 DEBUG : both10: md5 = b4e4562513e3e138fc42adec1f863294 OK 2025/05/16 02:54:29 DEBUG : only10: md5 = a1c006c26457990ccaaa14d6d0289921 OK 2025/05/16 02:54:29 DEBUG : both11: md5 = f9ada34ad2257c4c4d4cf8a1eb7fe3c9 OK 2025/05/16 02:54:29 DEBUG : only11: md5 = e41cc44d956e0524cb66bd3f7a310a6b OK 2025/05/16 02:54:34 DEBUG : both12: md5 = 07abd45026f52c1155149b142c685d44 OK 2025/05/16 02:54:35 DEBUG : only12: md5 = 6bad198d2413d43b34ae11dfa06976a8 OK 2025/05/16 02:54:35 DEBUG : both13: md5 = e51e337c8af8267ff1de914b93422578 OK 2025/05/16 02:54:40 DEBUG : only13: md5 = 45813d435f3f7839009e05d48a367c4a OK 2025/05/16 02:54:45 DEBUG : both14: md5 = f72a758a0cec70e42182c5fcc19e3467 OK 2025/05/16 02:54:50 DEBUG : only14: md5 = 599f116044f530cb7658bf39f07be098 OK 2025/05/16 02:54:56 DEBUG : both15: md5 = af3ce02cc4cc2d46d4ebc518e6374680 OK 2025/05/16 02:54:56 DEBUG : only15: md5 = afaa80d75a01743a60d6c2cad9ed94d2 OK 2025/05/16 02:55:01 DEBUG : both16: md5 = 1ccafbdb7ac6ccb90422fb3a823e8c8c OK 2025/05/16 02:55:01 DEBUG : only16: md5 = 9a476e2e4da4c5f948cc7cef9c8a9a81 OK 2025/05/16 02:55:07 DEBUG : both17: md5 = 58250584058d1ee54e28a0b6fb2f71fd OK 2025/05/16 02:55:12 DEBUG : only17: md5 = 27496e89eb364e580d53431eddf8ff7a OK 2025/05/16 02:55:17 DEBUG : both18: md5 = a31fa3cdf666a9fc3b760a8d654f64dc OK 2025/05/16 02:55:17 DEBUG : only18: md5 = d4b3f98c9163f8da6d40bcbad18944b8 OK 2025/05/16 02:55:22 DEBUG : both19: md5 = 90079c8462edca7d3d30243ee710bbfb OK 2025/05/16 02:55:27 DEBUG : only19: md5 = f540c4071ee574ea20d3ef7052545094 OK 2025/05/16 02:56:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for checks to finish 2025/05/16 02:56:15 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both0: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both10: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both11: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both13: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both12: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both14: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both15: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both16: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both17: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both18: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both2: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both4: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both5: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both6: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both7: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both8: Unchanged skipping 2025/05/16 02:56:15 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:15 DEBUG : both9: Unchanged skipping 2025/05/16 02:56:15 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/05/16 02:56:15 DEBUG : only0: md5 = 724f2da0a63e952f72c23bcfdfb6856c OK 2025/05/16 02:56:15 INFO : only0: Copied (replaced existing) 2025/05/16 02:56:15 DEBUG : only11: md5 = 315f48d8255a777b84f6b1c92ae8fa5b OK 2025/05/16 02:56:15 INFO : only11: Copied (replaced existing) 2025/05/16 02:56:16 DEBUG : only12: md5 = 7031b37f12e716570039a2a82326b73f OK 2025/05/16 02:56:16 INFO : only12: Copied (replaced existing) 2025/05/16 02:56:20 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:20 DEBUG : both1: Unchanged skipping 2025/05/16 02:56:20 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:20 DEBUG : both19: Unchanged skipping 2025/05/16 02:56:20 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/05/16 02:56:20 DEBUG : both3: Unchanged skipping 2025/05/16 02:56:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Waiting for transfers to finish 2025/05/16 02:56:21 DEBUG : only10: md5 = 758cfd3f9c956965a9db23fc4bf5991c OK 2025/05/16 02:56:21 INFO : only10: Copied (replaced existing) 2025/05/16 02:56:21 DEBUG : only1: md5 = 08291ebc9ac9cdbebae37c2280a0cafa OK 2025/05/16 02:56:21 INFO : only1: Copied (replaced existing) 2025/05/16 02:56:21 DEBUG : only15: md5 = e04148640b5c9bdee6a935b1904051b3 OK 2025/05/16 02:56:21 INFO : only15: Copied (replaced existing) 2025/05/16 02:56:21 DEBUG : only14: md5 = b86fb8ecd20dc415d2232a1af449ba7c OK 2025/05/16 02:56:21 INFO : only14: Copied (replaced existing) 2025/05/16 02:56:21 DEBUG : only16: md5 = 937c675577a786fd3453ba7f1c23d799 OK 2025/05/16 02:56:21 INFO : only16: Copied (replaced existing) 2025/05/16 02:56:21 DEBUG : only18: md5 = 761f58b43fd45b18389310fa24e71822 OK 2025/05/16 02:56:21 INFO : only18: Copied (replaced existing) 2025/05/16 02:56:21 DEBUG : only2: md5 = 3cde6a8c214096f3a7dfe9c97decf005 OK 2025/05/16 02:56:21 INFO : only2: Copied (replaced existing) 2025/05/16 02:56:26 DEBUG : only13: md5 = bb7580fbd4676567cbeade799497e2c5 OK 2025/05/16 02:56:26 INFO : only13: Copied (replaced existing) 2025/05/16 02:56:26 DEBUG : only4: md5 = 7cc8ef5f3a7630c03612996908065c10 OK 2025/05/16 02:56:26 INFO : only4: Copied (replaced existing) 2025/05/16 02:56:26 DEBUG : only5: md5 = 89770f9e5bf7d09767ce01e781a4402b OK 2025/05/16 02:56:26 INFO : only5: Copied (replaced existing) 2025/05/16 02:56:26 DEBUG : only17: md5 = 07497d331e88694039408ee3e15307fb OK 2025/05/16 02:56:26 INFO : only17: Copied (replaced existing) 2025/05/16 02:56:26 DEBUG : only6: md5 = 382c037a4df0f127100a0b0498c32d93 OK 2025/05/16 02:56:26 INFO : only6: Copied (replaced existing) 2025/05/16 02:56:26 DEBUG : only7: md5 = 9692d76cbd5a5523fc55120e4483663c OK 2025/05/16 02:56:26 INFO : only7: Copied (replaced existing) 2025/05/16 02:56:27 DEBUG : only3: md5 = ace250424f18a69ea120502bab32d0dc OK 2025/05/16 02:56:27 INFO : only3: Copied (replaced existing) 2025/05/16 02:56:31 DEBUG : only19: md5 = 9f62334e38f3339d7ec5f265f66a6e97 OK 2025/05/16 02:56:31 INFO : only19: Copied (replaced existing) 2025/05/16 02:56:31 DEBUG : only9: md5 = dd16a7b288e66da1d3ac735b8f4332a6 OK 2025/05/16 02:56:31 INFO : only9: Copied (replaced existing) 2025/05/16 02:56:36 DEBUG : only8: md5 = cf824c0d7f3bd3793d1f73516eb3eb01 OK 2025/05/16 02:56:36 INFO : only8: Copied (replaced existing) 2025/05/16 02:56:36 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (370.95s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:59:40 DEBUG : empty_dir: Making directory with metadata 2025/05/16 02:59:40 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/05/16 02:59:40 DEBUG : empty_on_remote: Making directory with metadata 2025/05/16 02:59:40 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/05/16 02:59:40 INFO : empty_on_remote: Making directory 2025/05/16 02:59:40 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-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:59:46 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/05/16 02:59:46 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/05/16 02:59:46 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/05/16 02:59:46 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTime (17.10s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 02:59:58 DEBUG : empty_dir: Making directory with metadata 2025/05/16 02:59:58 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/05/16 02:59:58 DEBUG : empty_on_remote: Making directory with metadata 2025/05/16 02:59:58 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/05/16 02:59:58 INFO : empty_on_remote: Making directory 2025/05/16 02:59:58 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-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 03:00:03 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/05/16 03:00:03 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/05/16 03:00:03 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/05/16 03:00:03 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/05/16 03:00:03 INFO : empty_dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (17.08s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 03:00:15 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/05/16 03:00:15 INFO : sub dir: Making directory 2025/05/16 03:00:15 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-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (22.45s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" 2025/05/16 03:00:37 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/05/16 03:00:37 INFO : sub dir: Making directory 2025/05/16 03:00: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-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi'", Local "Local file system at /tmp/rclone3889086274", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (22.31s) PASS 2025/05/16 03:00:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zugatar4beqi': Purge remote 2025/05/16 03:00:59 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 52m49.7395892s (try 2/5)