"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2022/04/20 06:08:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1" 2022/04/20 06:08:16 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/04/20 06:08:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1.bin" 2022/04/20 06:08:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1" 2022/04/20 06:08:17 DEBUG : Creating backend with remote "/tmp/rclone2774870069" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.02s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:17 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2022/04/20 06:08:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish --- PASS: TestCopyWithDryRun (0.39s) === RUN TestCopy run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:18 DEBUG : sub dir/hello world: md5 = 7033d8f48df6a041094108f27abc4872 OK 2022/04/20 06:08:18 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopy (1.14s) === RUN TestCopyMissingDirectory run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:19 DEBUG : Creating backend with remote "/non-existing" 2022/04/20 06:08:19 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2022/04/20 06:08:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.20s) === RUN TestCopyNoTraverse run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:19 DEBUG : sub dir/hello world: md5 = c6b0345c3cee751639dc80347204c73e OK 2022/04/20 06:08:19 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (0.79s) === RUN TestCopyCheckFirst run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:20 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Running all checks before starting transfers 2022/04/20 06:08:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:20 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Checks finished, now starting transfers 2022/04/20 06:08:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:20 DEBUG : sub dir/hello world: md5 = 76067d4c509310b36b3403470e3ada28 OK 2022/04/20 06:08:20 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (0.94s) === RUN TestSyncNoTraverse run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:20 ERROR : Ignoring --no-traverse with sync 2022/04/20 06:08:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:21 DEBUG : sub dir/hello world: md5 = 9b48eda035da9055f3be25a43c3d62c6 OK 2022/04/20 06:08:21 INFO : sub dir/hello world: Copied (new) 2022/04/20 06:08:21 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (0.97s) === RUN TestCopyWithDepth run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:22 DEBUG : hello world2: md5 = efec9cfb0d35ab822861c8e5353b7860 OK 2022/04/20 06:08:22 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (1.54s) === RUN TestCopyWithFilesFrom run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:23 DEBUG : hello world2: Excluded 2022/04/20 06:08:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:24 DEBUG : potato2: md5 = 46c743b71e21108867fae6f60d6e8b26 OK 2022/04/20 06:08:24 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (1.26s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:25 DEBUG : potato2: md5 = 52358709c174fae171026674fd854314 OK 2022/04/20 06:08:25 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (0.95s) === RUN TestCopyEmptyDirectories run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:25 DEBUG : sub dir2: Making directory 2022/04/20 06:08:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:26 DEBUG : sub dir/hello world: md5 = 6ecf9214f2be7e35d60bca9032a15a7a OK 2022/04/20 06:08:26 INFO : sub dir/hello world: Copied (new) 2022/04/20 06:08:26 DEBUG : sub dir2: Making directory 2022/04/20 06:08:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': copied 1 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestCopyEmptyDirectories (1.07s) === RUN TestMoveEmptyDirectories run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:26 DEBUG : sub dir2: Making directory 2022/04/20 06:08:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:27 DEBUG : sub dir/hello world: md5 = 1bcd060494bc3dbb5b8aa3d047b462ee OK 2022/04/20 06:08:27 INFO : sub dir/hello world: Copied (new) 2022/04/20 06:08:27 INFO : sub dir/hello world: Deleted 2022/04/20 06:08:27 DEBUG : sub dir: Making directory 2022/04/20 06:08:27 DEBUG : sub dir2: Making directory 2022/04/20 06:08:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': copied 2 directories fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestMoveEmptyDirectories (1.01s) === RUN TestSyncEmptyDirectories run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:27 DEBUG : sub dir2: Making directory 2022/04/20 06:08:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:28 DEBUG : sub dir/hello world: md5 = 515e30536a27eb1a927be6d7b5a6cb84 OK 2022/04/20 06:08:28 INFO : sub dir/hello world: Copied (new) 2022/04/20 06:08:28 DEBUG : sub dir2: Making directory 2022/04/20 06:08:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': copied 1 directories 2022/04/20 06:08:28 DEBUG : Waiting for deletions to finish fstest.go:251: Filtering empty directory "sub dir2" --- PASS: TestSyncEmptyDirectories (0.88s) === RUN TestServerSideCopy run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:29 DEBUG : sub dir/hello world: md5 = f1073d03670260d91ae421ba59aa84a0 OK 2022/04/20 06:08:29 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-maxohis8suvawoz6sogodeq6" 2022/04/20 06:08:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-maxohis8suvawoz6sogodeq6.bin" 2022/04/20 06:08:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-maxohis8suvawoz6sogodeq6" sync_test.go:275: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1' -> Encrypted drive 'TestCryptSwift:rclone-test-maxohis8suvawoz6sogodeq6' 2022/04/20 06:08:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maxohis8suvawoz6sogodeq6': Waiting for checks to finish 2022/04/20 06:08:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maxohis8suvawoz6sogodeq6': Waiting for transfers to finish 2022/04/20 06:08:31 INFO : sub dir/hello world: Copied (server-side copy) 2022/04/20 06:08:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maxohis8suvawoz6sogodeq6': Purge remote 2022/04/20 06:08:31 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:32 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (3.93s) === RUN TestCopyAfterDelete run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:33 DEBUG : sub dir/hello world: md5 = 5e939e694dc7a9d763e7f8d7927a51c4 OK 2022/04/20 06:08:33 ERROR : : error listing: directory not found 2022/04/20 06:08:33 DEBUG : Local file system at /tmp/rclone2774870069: Making directory 2022/04/20 06:08:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish --- PASS: TestCopyAfterDelete (1.18s) === RUN TestCopyRedownload run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:33 DEBUG : sub dir/hello world: md5 = 4a1919aa3702250eb59e21aa08cc4c57 OK 2022/04/20 06:08:34 DEBUG : Local file system at /tmp/rclone2774870069: Waiting for checks to finish 2022/04/20 06:08:34 DEBUG : Local file system at /tmp/rclone2774870069: Waiting for transfers to finish 2022/04/20 06:08:34 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (0.93s) === RUN TestSyncBasedOnCheckSum run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:35 DEBUG : check sum: md5 = 6c44143b84e00425aa4fb27c37988677 OK 2022/04/20 06:08:35 INFO : check sum: Copied (new) 2022/04/20 06:08:35 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:35 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2022/04/20 06:08:35 DEBUG : check sum: Size of src and dst objects identical 2022/04/20 06:08:35 DEBUG : check sum: Unchanged skipping 2022/04/20 06:08:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:35 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:35 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (1.54s) === RUN TestSyncSizeOnly run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:37 DEBUG : sizeonly: md5 = 64eff5184b18f7672bba10cbced900b5 OK 2022/04/20 06:08:37 INFO : sizeonly: Copied (new) 2022/04/20 06:08:37 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:37 DEBUG : sizeonly: Sizes identical 2022/04/20 06:08:37 DEBUG : sizeonly: Unchanged skipping 2022/04/20 06:08:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:37 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:37 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (1.61s) === RUN TestSyncIgnoreSize run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:38 DEBUG : ignore-size: md5 = f809f45eb9cabd5beec2dfc0c0753227 OK 2022/04/20 06:08:38 INFO : ignore-size: Copied (new) 2022/04/20 06:08:38 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:39 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:08:39 DEBUG : ignore-size: Unchanged skipping 2022/04/20 06:08:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:39 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:39 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (1.79s) === RUN TestSyncIgnoreTimes run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:40 DEBUG : existing: md5 = 38983c8f349100f03c422a64e7a1fd05 OK 2022/04/20 06:08:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:40 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:08:40 DEBUG : existing: Unchanged skipping 2022/04/20 06:08:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:40 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:40 INFO : There was nothing to transfer 2022/04/20 06:08:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:40 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2022/04/20 06:08:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:41 DEBUG : existing: md5 = 119d20012cca2802c2cf61d0416cf498 OK 2022/04/20 06:08:41 INFO : existing: Copied (replaced existing) 2022/04/20 06:08:41 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (2.06s) === RUN TestSyncIgnoreExisting run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:42 DEBUG : existing: md5 = 5a6199d6f704cff01e1c62c1e8081a44 OK 2022/04/20 06:08:42 INFO : existing: Copied (new) 2022/04/20 06:08:42 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:42 DEBUG : existing: Destination exists, skipping 2022/04/20 06:08:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:42 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:42 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (1.20s) === RUN TestSyncIgnoreErrors run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:43 DEBUG : b/potato: md5 = 9c956c68457a882d62f87c546bc9a2b7 OK 2022/04/20 06:08:43 DEBUG : c/non empty space: md5 = e89873866dbbac74c76e0278bf52bec6 OK 2022/04/20 06:08:43 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/04/20 06:08:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:44 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:08:44 DEBUG : c/non empty space: Unchanged skipping 2022/04/20 06:08:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:44 DEBUG : a/potato2: md5 = d3b8bce307f39b563bd742ca0304dd78 OK 2022/04/20 06:08:44 INFO : a/potato2: Copied (new) 2022/04/20 06:08:44 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:44 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (2.54s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:45 DEBUG : empty space: md5 = fbf49975f43263c927f215d63f779560 OK 2022/04/20 06:08:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:46 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 2022/04/20 06:08:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:46 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2022/04/20 06:08:46 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:46 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 2022/04/20 06:08:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:46 DEBUG : empty space: md5 = 7656ab4c6d1030459b6470c49e445fdd OK 2022/04/20 06:08:46 INFO : empty space: Copied (replaced existing) 2022/04/20 06:08:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingModtimeOnly (1.60s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" sync_test.go:577: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.19s) === RUN TestSyncDoesntUpdateModtime run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:47 DEBUG : foo: md5 = 54d351c36b09bc7ab3bfb7ee5b198c58 OK 2022/04/20 06:08:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:48 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2022/04/20 06:08:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:48 DEBUG : foo: md5 = 6be7ab1644cf28a9ef0587a30f340147 OK 2022/04/20 06:08:48 INFO : foo: Copied (replaced existing) 2022/04/20 06:08:48 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (2.02s) === RUN TestSyncAfterAddingAFile run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:49 DEBUG : empty space: md5 = ca906c8eda4d3505f5230a21a8312c38 OK 2022/04/20 06:08:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:49 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:08:49 DEBUG : empty space: Unchanged skipping 2022/04/20 06:08:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:50 DEBUG : potato: md5 = 8ec007254720b2b081fc640fb77effb8 OK 2022/04/20 06:08:50 INFO : potato: Copied (new) 2022/04/20 06:08:50 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (1.88s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:51 DEBUG : potato: md5 = fe4bdc2a0ccdcbb47f0fefdff37fee61 OK 2022/04/20 06:08:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:51 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2022/04/20 06:08:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:51 DEBUG : potato: md5 = 67f5f602e884e824e648a3609f337a59 OK 2022/04/20 06:08:51 INFO : potato: Copied (replaced existing) 2022/04/20 06:08:51 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (1.37s) === RUN TestSyncAfterChangingContentsOnly run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:52 DEBUG : potato: md5 = a9cf5b7be513f29c4768167386e6c0d2 OK 2022/04/20 06:08:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:53 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 2022/04/20 06:08:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:53 DEBUG : potato: md5 = c8c7bded537bed72de036a72f6f2dc01 OK 2022/04/20 06:08:53 INFO : potato: Copied (replaced existing) 2022/04/20 06:08:53 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (1.24s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:54 DEBUG : potato: md5 = 26057c5a7cb3d70b7296276cf760a06f OK 2022/04/20 06:08:54 DEBUG : empty space: md5 = abe9091766dcdece0b36440207435f36 OK 2022/04/20 06:08:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:54 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2022/04/20 06:08:54 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:08:54 DEBUG : empty space: Unchanged skipping 2022/04/20 06:08:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:54 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:54 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (1.60s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:55 DEBUG : potato: md5 = 456482d10697b5930cc6c3bd79bef2e0 OK 2022/04/20 06:08:55 DEBUG : empty space: md5 = 3b3efea3432dcb31179a7ed366eaafae OK 2022/04/20 06:08:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:56 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:08:56 DEBUG : empty space: Unchanged skipping 2022/04/20 06:08:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:56 DEBUG : potato2: md5 = fef38f79445c2c222faa501a7f09fc2e OK 2022/04/20 06:08:56 INFO : potato2: Copied (new) 2022/04/20 06:08:56 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:56 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.10s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:57 DEBUG : b/potato: md5 = daa0d29c912e70c7ae7e2814d2c7866e OK 2022/04/20 06:08:57 DEBUG : c/non empty space: md5 = b5c29829b9421151b588b403e68a2853 OK 2022/04/20 06:08:57 DEBUG : d: Making directory 2022/04/20 06:08:57 DEBUG : d/e: Making directory fstest.go:251: Filtering empty directory "d" fstest.go:251: Filtering empty directory "d/e" 2022/04/20 06:08:58 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:08:58 DEBUG : c/non empty space: Unchanged skipping 2022/04/20 06:08:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:08:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:08:58 DEBUG : a/potato2: md5 = 5b494d6bd84e345bb3415199036a46ef OK 2022/04/20 06:08:58 INFO : a/potato2: Copied (new) 2022/04/20 06:08:58 DEBUG : Waiting for deletions to finish 2022/04/20 06:08:58 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (2.00s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:08:59 DEBUG : b/potato: md5 = 45e158c4bf1d74a4d41ba5aed8006849 OK 2022/04/20 06:08:59 DEBUG : c/non empty space: md5 = 36b15342f8bc43564853c522a92b4135 OK 2022/04/20 06:08:59 DEBUG : d: Making directory fstest.go:251: Filtering empty directory "d" 2022/04/20 06:09:00 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:00 DEBUG : c/non empty space: Unchanged skipping 2022/04/20 06:09:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:00 DEBUG : a/potato2: md5 = d4f18a11ef78779a01cb3e1f095c6c03 OK 2022/04/20 06:09:00 INFO : a/potato2: Copied (new) 2022/04/20 06:09:00 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': not deleting files as there were IO errors 2022/04/20 06:09:00 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': not deleting directories as there were IO errors fstest.go:251: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (1.99s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:01 DEBUG : potato: md5 = fc13277f4be8378fb010e1ca59885a86 OK 2022/04/20 06:09:02 DEBUG : empty space: md5 = ecd2c4d5009de8ca3443ff454b327beb OK 2022/04/20 06:09:02 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:03 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:03 DEBUG : empty space: Unchanged skipping 2022/04/20 06:09:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:03 INFO : potato: Deleted 2022/04/20 06:09:03 DEBUG : potato2: md5 = 70fed017d40354d09e40bb3fce80575d OK 2022/04/20 06:09:03 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteDuring (3.41s) === RUN TestSyncDeleteBefore run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:05 DEBUG : potato: md5 = a1d20e663641084d9008b5f23fc3f7e9 OK 2022/04/20 06:09:05 DEBUG : empty space: md5 = 70fa06bfbb93a04b2816747ac1147cfb OK 2022/04/20 06:09:05 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:06 INFO : potato: Deleted 2022/04/20 06:09:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:07 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:07 DEBUG : empty space: Unchanged skipping 2022/04/20 06:09:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:07 DEBUG : potato2: md5 = baf83aaceacc99f134d9b0dd1d43a989 OK 2022/04/20 06:09:07 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (3.43s) === RUN TestCopyDeleteBefore run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:08 DEBUG : potato: md5 = 0524438c96adc652595649fa70b11fb6 OK 2022/04/20 06:09:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:09 DEBUG : potato2: md5 = a900a34a925d03590aa84a58272862e2 OK 2022/04/20 06:09:09 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (1.60s) === RUN TestSyncWithExclude run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:10 DEBUG : potato2: md5 = baabe38688e8c3ed0354801fa592739d OK 2022/04/20 06:09:10 DEBUG : empty space: md5 = e5d53fe76dc5dccb28b0903200c56f15 OK 2022/04/20 06:09:10 DEBUG : enormous: Excluded 2022/04/20 06:09:10 DEBUG : potato2: Excluded 2022/04/20 06:09:10 DEBUG : potato2: Excluded 2022/04/20 06:09:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:10 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:10 DEBUG : empty space: Unchanged skipping 2022/04/20 06:09:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:10 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:10 INFO : There was nothing to transfer 2022/04/20 06:09:10 DEBUG : enormous: Excluded 2022/04/20 06:09:10 DEBUG : potato2: Excluded 2022/04/20 06:09:10 DEBUG : potato2: Excluded 2022/04/20 06:09:10 DEBUG : Local file system at /tmp/rclone2774870069: Waiting for checks to finish 2022/04/20 06:09:10 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:10 DEBUG : empty space: Unchanged skipping 2022/04/20 06:09:10 DEBUG : Local file system at /tmp/rclone2774870069: Waiting for transfers to finish 2022/04/20 06:09:10 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:10 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (2.25s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:12 DEBUG : potato2: md5 = daeba73413c24dff9f610a457e440911 OK 2022/04/20 06:09:12 DEBUG : empty space: md5 = 9aeb993c25a3f30569461b5ce8c3d095 OK 2022/04/20 06:09:13 DEBUG : enormous: md5 = d3dd8fc9a3baf84ca2a01e405124cf3f OK 2022/04/20 06:09:13 DEBUG : enormous: Excluded 2022/04/20 06:09:13 DEBUG : potato2: Excluded 2022/04/20 06:09:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:13 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:13 DEBUG : empty space: Unchanged skipping 2022/04/20 06:09:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:13 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:13 INFO : potato2: Deleted 2022/04/20 06:09:13 INFO : enormous: Deleted 2022/04/20 06:09:13 INFO : There was nothing to transfer 2022/04/20 06:09:14 DEBUG : Local file system at /tmp/rclone2774870069: Waiting for checks to finish 2022/04/20 06:09:14 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:14 DEBUG : empty space: Unchanged skipping 2022/04/20 06:09:14 DEBUG : Local file system at /tmp/rclone2774870069: Waiting for transfers to finish 2022/04/20 06:09:14 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:14 INFO : enormous: Deleted 2022/04/20 06:09:14 INFO : potato2: Deleted 2022/04/20 06:09:14 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (2.53s) === RUN TestSyncWithUpdateOlder run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:15 DEBUG : one: md5 = 7db1aae11082c2abbd59e7707be65216 OK 2022/04/20 06:09:15 DEBUG : two: md5 = 4b7e1b63dae55acf52e8a1651ac78a53 OK 2022/04/20 06:09:15 DEBUG : three: md5 = 1faeef6da736e0556326b55cc9865df2 OK 2022/04/20 06:09:16 DEBUG : four: md5 = 4045731d9e51c1c58c51d982069628cf OK 2022/04/20 06:09:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:16 DEBUG : three: Sizes identical 2022/04/20 06:09:16 DEBUG : one: Destination is newer than source, skipping 2022/04/20 06:09:16 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2022/04/20 06:09:16 DEBUG : four: Sizes differ (src 4 vs dst 8) 2022/04/20 06:09:16 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2022/04/20 06:09:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:17 DEBUG : two: md5 = 67b92f23e379d052d1d93ad08aa02ba6 OK 2022/04/20 06:09:17 INFO : two: Copied (replaced existing) 2022/04/20 06:09:17 DEBUG : four: md5 = 4c4905838820ac97681f760de1f8ac6d OK 2022/04/20 06:09:17 INFO : four: Copied (replaced existing) 2022/04/20 06:09:17 DEBUG : five: md5 = af76a665b7b58076c08cb3f29432eeb3 OK 2022/04/20 06:09:17 INFO : five: Copied (new) 2022/04/20 06:09:17 DEBUG : Waiting for deletions to finish sync_test.go:992: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (4.27s) === RUN TestSyncWithMaxDuration sync_test.go:1009: Skipping test on non local remote --- SKIP: TestSyncWithMaxDuration (0.00s) === RUN TestSyncWithTrackRenames run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" sync_test.go:1058: Can track renames: false 2022/04/20 06:09:18 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Ignoring --track-renames as the source and destination do not have a common hash 2022/04/20 06:09:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:19 DEBUG : potato: md5 = 61387dfddf2c3af2986062cd4865010a OK 2022/04/20 06:09:19 INFO : potato: Copied (new) 2022/04/20 06:09:19 DEBUG : yam: md5 = 1955313cd7f54d028ec35f5d008998a7 OK 2022/04/20 06:09:19 INFO : yam: Copied (new) 2022/04/20 06:09:19 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:20 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Ignoring --track-renames as the source and destination do not have a common hash 2022/04/20 06:09:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:20 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:20 DEBUG : potato: Unchanged skipping 2022/04/20 06:09:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:20 DEBUG : yaml: md5 = dc62a7fe594c931cc04bd597a1fd5a6c OK 2022/04/20 06:09:20 INFO : yaml: Copied (new) 2022/04/20 06:09:20 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:20 INFO : yam: Deleted --- PASS: TestSyncWithTrackRenames (2.89s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" sync_test.go:1127: Can track renames: true 2022/04/20 06:09:21 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Making map for --track-renames 2022/04/20 06:09:21 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Finished making map for --track-renames 2022/04/20 06:09:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for renames to finish 2022/04/20 06:09:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:22 DEBUG : potato: md5 = 254ecbd3b50a9864207212d262bfaf72 OK 2022/04/20 06:09:22 INFO : potato: Copied (new) 2022/04/20 06:09:22 DEBUG : yam: md5 = 01bb80c7c2b6f6a1383e44b11f6920b8 OK 2022/04/20 06:09:22 INFO : yam: Copied (new) 2022/04/20 06:09:22 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:22 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Making map for --track-renames 2022/04/20 06:09:22 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Finished making map for --track-renames 2022/04/20 06:09:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:22 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:22 DEBUG : potato: Unchanged skipping 2022/04/20 06:09:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for renames to finish 2022/04/20 06:09:22 INFO : yam: Copied (server-side copy) to: yaml 2022/04/20 06:09:23 INFO : yam: Deleted 2022/04/20 06:09:23 INFO : yaml: Renamed from "yam" 2022/04/20 06:09:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (1.87s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" sync_test.go:1163: Can track renames: true 2022/04/20 06:09:23 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Making map for --track-renames 2022/04/20 06:09:23 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Finished making map for --track-renames 2022/04/20 06:09:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for renames to finish 2022/04/20 06:09:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:24 DEBUG : potato: md5 = ea3931d3974c2d041501bd38ff132b6a OK 2022/04/20 06:09:24 INFO : potato: Copied (new) 2022/04/20 06:09:24 DEBUG : sub/yam: md5 = f63f06432d3292dbd41b8be1019b8f63 OK 2022/04/20 06:09:24 INFO : sub/yam: Copied (new) 2022/04/20 06:09:24 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:24 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:24 DEBUG : potato: Unchanged skipping 2022/04/20 06:09:24 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Making map for --track-renames 2022/04/20 06:09:24 INFO : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Finished making map for --track-renames 2022/04/20 06:09:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for renames to finish 2022/04/20 06:09:24 INFO : sub/yam: Copied (server-side copy) to: yam 2022/04/20 06:09:24 INFO : sub/yam: Deleted 2022/04/20 06:09:24 INFO : yam: Renamed from "sub/yam" 2022/04/20 06:09:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:24 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (2.10s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:26 DEBUG : sub dir/hello world: md5 = 9794343ea8d186a94a9b8e6b0eab43bd OK 2022/04/20 06:09:26 INFO : sub dir/hello world: Copied (new) 2022/04/20 06:09:26 INFO : sub dir/hello world: Deleted 2022/04/20 06:09:26 DEBUG : nested/sub dir/file: md5 = 2b1fbd45f44c52decdf1d4fa632eee41 OK 2022/04/20 06:09:26 INFO : nested/sub dir/file: Copied (new) 2022/04/20 06:09:26 INFO : nested/sub dir/file: Deleted 2022/04/20 06:09:26 INFO : sub dir: Removing directory 2022/04/20 06:09:26 INFO : nested/sub dir: Removing directory 2022/04/20 06:09:26 INFO : nested: Removing directory 2022/04/20 06:09:26 DEBUG : Local file system at /tmp/rclone2774870069: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (1.28s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:27 DEBUG : sub dir/hello world: md5 = d33aaa0387d750d52e51e4706d8f4cc9 OK 2022/04/20 06:09:27 INFO : sub dir/hello world: Copied (new) 2022/04/20 06:09:27 INFO : sub dir/hello world: Deleted 2022/04/20 06:09:27 DEBUG : nested/sub dir/file: md5 = 3bdc152d7e261a59ad304eaa7850cd21 OK 2022/04/20 06:09:27 INFO : nested/sub dir/file: Copied (new) 2022/04/20 06:09:27 INFO : nested/sub dir/file: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (1.07s) === RUN TestMoveWithIgnoreExisting run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:28 DEBUG : existing: md5 = f26a285f8794c6887327e0487d4c5d8d OK 2022/04/20 06:09:28 INFO : existing: Copied (new) 2022/04/20 06:09:28 INFO : existing: Deleted 2022/04/20 06:09:28 DEBUG : existing-b: md5 = 9e8e32306de87a49f4e92980bb86baa4 OK 2022/04/20 06:09:28 INFO : existing-b: Copied (new) 2022/04/20 06:09:28 INFO : existing-b: Deleted 2022/04/20 06:09:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:09:28 DEBUG : existing: Destination exists, skipping 2022/04/20 06:09:28 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2022/04/20 06:09:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:09:28 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (1.53s) === RUN TestServerSideMove run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:29 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qedanoc7karadiy8pogeyux2" 2022/04/20 06:09:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qedanoc7karadiy8pogeyux2.bin" 2022/04/20 06:09:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qedanoc7karadiy8pogeyux2" 2022/04/20 06:09:31 DEBUG : potato2: md5 = f1fa800e25b88631e0957d4b4cfbcf1d OK 2022/04/20 06:09:31 DEBUG : empty space: md5 = d7f580e90c7ce572723a62513aadf4ef OK 2022/04/20 06:09:31 DEBUG : potato3: md5 = 6cbda9e752551164f32c94500b0d291a OK sync_test.go:1215: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1' -> Encrypted drive 'TestCryptSwift:rclone-test-qedanoc7karadiy8pogeyux2' 2022/04/20 06:09:32 DEBUG : empty space: md5 = b5bdd927b3fd8e1b6ba240ad6e1f3407 OK 2022/04/20 06:09:33 DEBUG : potato3: md5 = 2e1ff31c81ffe76997b009acb76fe9b8 OK 2022/04/20 06:09:33 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/04/20 06:09:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qedanoc7karadiy8pogeyux2': Waiting for checks to finish 2022/04/20 06:09:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:33 DEBUG : empty space: Unchanged skipping 2022/04/20 06:09:33 INFO : potato2: Copied (server-side copy) 2022/04/20 06:09:33 INFO : empty space: Deleted 2022/04/20 06:09:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qedanoc7karadiy8pogeyux2': Waiting for transfers to finish 2022/04/20 06:09:33 INFO : potato2: Deleted 2022/04/20 06:09:33 INFO : potato3: Copied (server-side copy) 2022/04/20 06:09:34 INFO : potato3: Deleted 2022/04/20 06:09:34 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-sigomuz1katigep4pumoguc3" 2022/04/20 06:09:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sigomuz1katigep4pumoguc3.bin" 2022/04/20 06:09:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sigomuz1katigep4pumoguc3" 2022/04/20 06:09:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sigomuz1katigep4pumoguc3': Waiting for checks to finish 2022/04/20 06:09:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sigomuz1katigep4pumoguc3': Waiting for transfers to finish 2022/04/20 06:09:36 INFO : empty space: Copied (server-side copy) 2022/04/20 06:09:36 INFO : potato3: Copied (server-side copy) 2022/04/20 06:09:36 INFO : potato2: Copied (server-side copy) 2022/04/20 06:09:36 INFO : potato2: Deleted 2022/04/20 06:09:36 INFO : potato3: Deleted 2022/04/20 06:09:36 INFO : empty space: Deleted 2022/04/20 06:09:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sigomuz1katigep4pumoguc3': Purge remote 2022/04/20 06:09:37 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:37 INFO : potato2.bin: Deleted 2022/04/20 06:09:37 INFO : empty space.bin: Deleted 2022/04/20 06:09:37 INFO : potato3.bin: Deleted 2022/04/20 06:09:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qedanoc7karadiy8pogeyux2': Purge remote 2022/04/20 06:09:37 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (8.23s) === RUN TestServerSideMoveWithFilter run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-liyuzaw7tepabeq5giruciy5" 2022/04/20 06:09:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-liyuzaw7tepabeq5giruciy5.bin" 2022/04/20 06:09:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-liyuzaw7tepabeq5giruciy5" 2022/04/20 06:09:39 DEBUG : potato2: md5 = a13f74bb1130d48da02eb06fa7e4cbf6 OK 2022/04/20 06:09:39 DEBUG : empty space: md5 = 21a042c29ac2aa2864d4dbd15baad45c OK 2022/04/20 06:09:40 DEBUG : potato3: md5 = 3b194a247adf8a1248ec5b98647cd068 OK sync_test.go:1215: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1' -> Encrypted drive 'TestCryptSwift:rclone-test-liyuzaw7tepabeq5giruciy5' 2022/04/20 06:09:41 DEBUG : empty space: md5 = a92258556af0804ade714caae7eec8c4 OK 2022/04/20 06:09:41 DEBUG : potato3: md5 = e8062417bbd4bd60ccf8dfbd1139d104 OK 2022/04/20 06:09:41 DEBUG : empty space: Excluded 2022/04/20 06:09:41 DEBUG : empty space: Excluded 2022/04/20 06:09:41 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/04/20 06:09:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyuzaw7tepabeq5giruciy5': Waiting for checks to finish 2022/04/20 06:09:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyuzaw7tepabeq5giruciy5': Waiting for transfers to finish 2022/04/20 06:09:42 INFO : potato2: Copied (server-side copy) 2022/04/20 06:09:42 INFO : potato3: Copied (server-side copy) 2022/04/20 06:09:42 INFO : potato2: Deleted 2022/04/20 06:09:42 INFO : potato3: Deleted 2022/04/20 06:09:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-jadumek9carogoy3hupekow3" 2022/04/20 06:09:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jadumek9carogoy3hupekow3.bin" 2022/04/20 06:09:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jadumek9carogoy3hupekow3" 2022/04/20 06:09:43 DEBUG : empty space: Excluded 2022/04/20 06:09:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jadumek9carogoy3hupekow3': Waiting for checks to finish 2022/04/20 06:09:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jadumek9carogoy3hupekow3': Waiting for transfers to finish 2022/04/20 06:09:44 INFO : potato2: Copied (server-side copy) 2022/04/20 06:09:44 INFO : potato2: Deleted 2022/04/20 06:09:44 INFO : potato3: Copied (server-side copy) 2022/04/20 06:09:44 INFO : potato3: Deleted 2022/04/20 06:09:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jadumek9carogoy3hupekow3': Purge remote 2022/04/20 06:09:45 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:45 INFO : potato2.bin: Deleted 2022/04/20 06:09:45 INFO : potato3.bin: Deleted 2022/04/20 06:09:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-liyuzaw7tepabeq5giruciy5': Purge remote 2022/04/20 06:09:45 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:46 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (8.76s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:46 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-baxolal4woyeboc0wisarof1" 2022/04/20 06:09:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-baxolal4woyeboc0wisarof1.bin" 2022/04/20 06:09:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-baxolal4woyeboc0wisarof1" 2022/04/20 06:09:47 DEBUG : potato2: md5 = fe3af394190daf3c21d275f96096339f OK 2022/04/20 06:09:48 DEBUG : empty space: md5 = f59949c84f441c58c4ec85b90c0abd29 OK 2022/04/20 06:09:48 DEBUG : potato3: md5 = 3f60c16581722a894d125171bd5f131c OK 2022/04/20 06:09:48 DEBUG : tomatoDir: Making directory sync_test.go:1215: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1' -> Encrypted drive 'TestCryptSwift:rclone-test-baxolal4woyeboc0wisarof1' 2022/04/20 06:09:49 DEBUG : empty space: md5 = 795061a4db739c35c6cff2812324590e OK 2022/04/20 06:09:49 DEBUG : potato3: md5 = 777ca9eef2c3a4e0e25b0c6394632c48 OK 2022/04/20 06:09:50 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2022/04/20 06:09:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-baxolal4woyeboc0wisarof1': Waiting for checks to finish 2022/04/20 06:09:50 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:09:50 DEBUG : empty space: Unchanged skipping 2022/04/20 06:09:50 INFO : empty space: Deleted 2022/04/20 06:09:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-baxolal4woyeboc0wisarof1': Waiting for transfers to finish 2022/04/20 06:09:50 INFO : potato3: Copied (server-side copy) 2022/04/20 06:09:50 INFO : potato3: Deleted 2022/04/20 06:09:50 INFO : potato2: Copied (server-side copy) 2022/04/20 06:09:50 INFO : potato2: Deleted 2022/04/20 06:09:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zirijay6giwexof6lomicah8" 2022/04/20 06:09:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zirijay6giwexof6lomicah8.bin" 2022/04/20 06:09:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zirijay6giwexof6lomicah8" 2022/04/20 06:09:52 DEBUG : tomatoDir: Making directory 2022/04/20 06:09:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zirijay6giwexof6lomicah8': Waiting for checks to finish 2022/04/20 06:09:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zirijay6giwexof6lomicah8': Waiting for transfers to finish 2022/04/20 06:09:52 INFO : empty space: Copied (server-side copy) 2022/04/20 06:09:52 INFO : empty space: Deleted 2022/04/20 06:09:52 INFO : potato2: Copied (server-side copy) 2022/04/20 06:09:52 INFO : potato3: Copied (server-side copy) 2022/04/20 06:09:52 INFO : potato2: Deleted 2022/04/20 06:09:53 INFO : potato3: Deleted 2022/04/20 06:09:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zirijay6giwexof6lomicah8': Purge remote 2022/04/20 06:09:53 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:53 INFO : potato2.bin: Deleted 2022/04/20 06:09:53 INFO : empty space.bin: Deleted 2022/04/20 06:09:53 INFO : potato3.bin: Deleted 2022/04/20 06:09:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-baxolal4woyeboc0wisarof1': Purge remote 2022/04/20 06:09:53 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (7.51s) === RUN TestServerSideMoveOverlap run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/rclone-move-test" 2022/04/20 06:09:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/rclone-move-test.bin" 2022/04/20 06:09:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/rclone-move-test" 2022/04/20 06:09:55 DEBUG : potato2: md5 = 3abae1f9e1a85c432abfda9774d03842 OK --- PASS: TestServerSideMoveOverlap (1.89s) === RUN TestSyncOverlap run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:56 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/rclone-sync-test" 2022/04/20 06:09:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/rclone-sync-test.bin" 2022/04/20 06:09:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/rclone-sync-test" --- PASS: TestSyncOverlap (1.16s) === RUN TestSyncCompareDest run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:09:57 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:09:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst.bin" 2022/04/20 06:09:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:09:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/CompareDest" 2022/04/20 06:09:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/CompareDest.bin" 2022/04/20 06:09:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/CompareDest" 2022/04/20 06:09:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:09:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:09:59 DEBUG : one: md5 = a2cbcc2452613d945e3de7ea1fa819f8 OK 2022/04/20 06:09:59 INFO : one: Copied (new) 2022/04/20 06:09:59 DEBUG : Waiting for deletions to finish 2022/04/20 06:09:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:09:59 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/04/20 06:09:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:00 DEBUG : one: md5 = 38ce4b5b77c45c3ecd24b23f606d3d2a OK 2022/04/20 06:10:00 INFO : one: Copied (replaced existing) 2022/04/20 06:10:00 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:00 DEBUG : dst/one: md5 = ae36731ec195f615910b43f67c91ee17 OK 2022/04/20 06:10:01 DEBUG : CompareDest/one: md5 = 396b4d3a134d381947865f14d38ce3b4 OK 2022/04/20 06:10:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:01 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:01 DEBUG : one: Destination found in --compare-dest, skipping 2022/04/20 06:10:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:01 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:01 INFO : There was nothing to transfer 2022/04/20 06:10:02 DEBUG : CompareDest/two: md5 = 26eb1f1efc599459b315c71362addb3a OK 2022/04/20 06:10:02 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:02 DEBUG : two: Destination found in --compare-dest, skipping 2022/04/20 06:10:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:02 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:02 DEBUG : one: Destination found in --compare-dest, skipping 2022/04/20 06:10:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:02 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:02 INFO : There was nothing to transfer 2022/04/20 06:10:02 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:02 DEBUG : two: Destination found in --compare-dest, skipping 2022/04/20 06:10:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:02 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:02 DEBUG : one: Destination found in --compare-dest, skipping 2022/04/20 06:10:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:02 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:02 INFO : There was nothing to transfer sync_test.go:1543: No hash on uploaded file so skipping compare timestamp test 2022/04/20 06:10:03 DEBUG : two: Sizes differ (src 5 vs dst 3) 2022/04/20 06:10:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:03 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:03 DEBUG : one: Destination found in --compare-dest, skipping 2022/04/20 06:10:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:03 DEBUG : two: md5 = 810e3d6bc103680a5d451cc0c9539137 OK 2022/04/20 06:10:03 INFO : two: Copied (new) 2022/04/20 06:10:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (7.92s) === RUN TestSyncMultipleCompareDest run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:10:05 DEBUG : pre-dest1/1: md5 = 6e6c6178044786f5d62aeb02d2794031 OK 2022/04/20 06:10:05 DEBUG : pre-dest2/2: md5 = 41a6ad177e9c13fc949f90591350b28b OK 2022/04/20 06:10:06 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dest" 2022/04/20 06:10:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dest.bin" 2022/04/20 06:10:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dest" 2022/04/20 06:10:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/pre-dest1" 2022/04/20 06:10:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/pre-dest1.bin" 2022/04/20 06:10:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/pre-dest1" 2022/04/20 06:10:08 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/pre-dest2" 2022/04/20 06:10:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/pre-dest2.bin" 2022/04/20 06:10:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/pre-dest2" 2022/04/20 06:10:09 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:09 DEBUG : 1: Destination found in --compare-dest, skipping 2022/04/20 06:10:09 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:09 DEBUG : 2: Destination found in --compare-dest, skipping 2022/04/20 06:10:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dest': Waiting for checks to finish 2022/04/20 06:10:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dest': Waiting for transfers to finish 2022/04/20 06:10:10 DEBUG : 3: md5 = 972863601e9200242d1c4a8c6f320770 OK 2022/04/20 06:10:10 INFO : 3: Copied (new) 2022/04/20 06:10:10 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (6.49s) === RUN TestSyncCopyDest run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:10:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:11 DEBUG : Config file has changed externaly - reloading 2022/04/20 06:10:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst.bin" 2022/04/20 06:10:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:12 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/CopyDest" 2022/04/20 06:10:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/CopyDest.bin" 2022/04/20 06:10:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/CopyDest" 2022/04/20 06:10:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:14 DEBUG : one: md5 = 3dfdf5665a26f29f1aa30bcd8eb422e5 OK 2022/04/20 06:10:14 INFO : one: Copied (new) 2022/04/20 06:10:14 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:14 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/04/20 06:10:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:15 DEBUG : one: md5 = 684cfa5347a2a118435efbe2df46428a OK 2022/04/20 06:10:15 INFO : one: Copied (replaced existing) 2022/04/20 06:10:15 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:15 DEBUG : dst/one: md5 = 20fd0b9d934583ded0b541fc5eb2c336 OK 2022/04/20 06:10:16 DEBUG : CopyDest/one: md5 = 4a0635b47db85c42aa51b904314695e8 OK 2022/04/20 06:10:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/BackupDir" 2022/04/20 06:10:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/BackupDir.bin" 2022/04/20 06:10:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/BackupDir" 2022/04/20 06:10:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:17 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:17 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/04/20 06:10:18 INFO : one: Copied (server-side copy) 2022/04/20 06:10:19 INFO : one: Deleted 2022/04/20 06:10:19 INFO : one: Copied (server-side copy) 2022/04/20 06:10:19 DEBUG : one: Destination found in --copy-dest, using server-side copy 2022/04/20 06:10:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:19 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:20 DEBUG : CopyDest/two: md5 = d73f7c778a53dc0e5b2855b3d005f182 OK 2022/04/20 06:10:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:21 INFO : two: Copied (server-side copy) 2022/04/20 06:10:21 DEBUG : two: Destination found in --copy-dest, using server-side copy 2022/04/20 06:10:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:21 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:21 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:21 DEBUG : one: Unchanged skipping 2022/04/20 06:10:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:21 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:22 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:22 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:22 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:22 DEBUG : one: Unchanged skipping 2022/04/20 06:10:22 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:22 DEBUG : two: Unchanged skipping 2022/04/20 06:10:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:22 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:22 INFO : There was nothing to transfer 2022/04/20 06:10:22 DEBUG : CopyDest/three: md5 = 904e53a3b958d9b842e08afab2cb385a OK 2022/04/20 06:10:23 DEBUG : three: Sizes differ (src 7 vs dst 5) 2022/04/20 06:10:23 DEBUG : three: Destination not found in --copy-dest 2022/04/20 06:10:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:23 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:23 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:23 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:23 DEBUG : one: Unchanged skipping 2022/04/20 06:10:23 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:23 DEBUG : two: Unchanged skipping 2022/04/20 06:10:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:23 DEBUG : three: md5 = d80644c9cf685ac1f3aa513fe91c97d1 OK 2022/04/20 06:10:23 INFO : three: Copied (new) 2022/04/20 06:10:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (14.33s) === RUN TestSyncBackupDir run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:10:26 DEBUG : dst/one: md5 = c5ff4a13cd617f4013ae97ed1887220a OK 2022/04/20 06:10:26 DEBUG : dst/two: md5 = 97bcb4eb1df49c9dd918386db2ba0c68 OK 2022/04/20 06:10:27 DEBUG : dst/three.txt: md5 = a239d70217bd1585b28293b125f1153d OK 2022/04/20 06:10:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst.bin" 2022/04/20 06:10:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:28 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/backup" 2022/04/20 06:10:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/backup.bin" 2022/04/20 06:10:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/backup" 2022/04/20 06:10:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/04/20 06:10:29 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:29 DEBUG : two: Unchanged skipping 2022/04/20 06:10:30 INFO : one: Copied (server-side copy) 2022/04/20 06:10:30 INFO : one: Deleted 2022/04/20 06:10:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:30 DEBUG : one: md5 = 90c5024e7dc6bae898ce7cee0223b1f1 OK 2022/04/20 06:10:30 INFO : one: Copied (new) 2022/04/20 06:10:30 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:31 INFO : three.txt: Copied (server-side copy) 2022/04/20 06:10:31 INFO : three.txt: Deleted 2022/04/20 06:10:31 INFO : three.txt: Moved into backup dir 2022/04/20 06:10:32 DEBUG : dst/three.txt: md5 = ee786d00a79d8cb5fea48ba93ca98593 OK 2022/04/20 06:10:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:32 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/04/20 06:10:32 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:32 DEBUG : two: Unchanged skipping 2022/04/20 06:10:33 INFO : one: Copied (server-side copy) 2022/04/20 06:10:33 INFO : one: Deleted 2022/04/20 06:10:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:34 DEBUG : one: md5 = 7d55aebca4abb311a4f1139b949a8771 OK 2022/04/20 06:10:34 INFO : one: Copied (new) 2022/04/20 06:10:34 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:34 INFO : three.txt: Copied (server-side copy) 2022/04/20 06:10:35 INFO : three.txt: Deleted 2022/04/20 06:10:35 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (10.64s) === RUN TestSyncBackupDirWithSuffix run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:10:37 DEBUG : dst/one: md5 = b42d3aad9ce431218251787d7cb7f675 OK 2022/04/20 06:10:37 DEBUG : dst/two: md5 = 92b7777fd0ab3e950005e348bea3f8e2 OK 2022/04/20 06:10:37 DEBUG : dst/three.txt: md5 = aa6b2f83c63dde6f3607055b648e2c85 OK 2022/04/20 06:10:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst.bin" 2022/04/20 06:10:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/backup" 2022/04/20 06:10:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/backup.bin" 2022/04/20 06:10:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/backup" 2022/04/20 06:10:39 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/04/20 06:10:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:39 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:39 DEBUG : two: Unchanged skipping 2022/04/20 06:10:40 INFO : one: Copied (server-side copy) to: one.bak 2022/04/20 06:10:40 INFO : one: Deleted 2022/04/20 06:10:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:40 DEBUG : one: md5 = 8385b26c1fc6d74f49b82beaf7bdd924 OK 2022/04/20 06:10:40 INFO : one: Copied (new) 2022/04/20 06:10:40 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:41 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/04/20 06:10:42 INFO : three.txt: Deleted 2022/04/20 06:10:42 INFO : three.txt: Moved into backup dir 2022/04/20 06:10:43 DEBUG : dst/three.txt: md5 = 0a42012d0a4d84f00f49802c107e6845 OK 2022/04/20 06:10:43 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/04/20 06:10:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:43 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:43 DEBUG : two: Unchanged skipping 2022/04/20 06:10:43 INFO : one: Copied (server-side copy) to: one.bak 2022/04/20 06:10:44 INFO : one: Deleted 2022/04/20 06:10:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:44 DEBUG : one: md5 = b3e6f3506da9bc32f2d00e0462ef6302 OK 2022/04/20 06:10:44 INFO : one: Copied (new) 2022/04/20 06:10:44 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:44 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/04/20 06:10:44 INFO : three.txt: Deleted 2022/04/20 06:10:44 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (9.36s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:10:46 DEBUG : dst/one: md5 = 6dc4ef857b0fc0aa38f2b1544d81929f OK 2022/04/20 06:10:46 DEBUG : dst/two: md5 = 3a8db365b24713b34aee21f496b96baf OK 2022/04/20 06:10:46 DEBUG : dst/three.txt: md5 = bcab9883ab775bb8f77072fd4a87cace OK 2022/04/20 06:10:47 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst.bin" 2022/04/20 06:10:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:47 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/backup" 2022/04/20 06:10:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/backup.bin" 2022/04/20 06:10:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/backup" 2022/04/20 06:10:48 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/04/20 06:10:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:48 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:48 DEBUG : two: Unchanged skipping 2022/04/20 06:10:49 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/04/20 06:10:50 INFO : one: Deleted 2022/04/20 06:10:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:50 DEBUG : one: md5 = e240fbb5a1c5f0056a9bdf1576d76897 OK 2022/04/20 06:10:50 INFO : one: Copied (new) 2022/04/20 06:10:50 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:51 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/04/20 06:10:51 INFO : three.txt: Deleted 2022/04/20 06:10:51 INFO : three.txt: Moved into backup dir 2022/04/20 06:10:52 DEBUG : dst/three.txt: md5 = 222336fe9894c7e9986a558082b58f78 OK 2022/04/20 06:10:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:52 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/04/20 06:10:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:52 DEBUG : two: Unchanged skipping 2022/04/20 06:10:52 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/04/20 06:10:52 INFO : one: Deleted 2022/04/20 06:10:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:53 DEBUG : one: md5 = 2f014e66d41b8755e8a1374df64be65c OK 2022/04/20 06:10:53 INFO : one: Copied (new) 2022/04/20 06:10:53 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:53 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/04/20 06:10:53 INFO : three.txt: Deleted 2022/04/20 06:10:53 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (9.12s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:10:55 DEBUG : dst/one: md5 = 60e13542c1065072845fabb9c1d0a964 OK 2022/04/20 06:10:55 DEBUG : dst/two: md5 = f02f6765ce85b408e4056c30e591fb30 OK 2022/04/20 06:10:56 DEBUG : dst/three.txt: md5 = 688b5ed7a129311fda4582210f13f573 OK 2022/04/20 06:10:56 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst.bin" 2022/04/20 06:10:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:10:57 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/04/20 06:10:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:57 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:57 DEBUG : two: Unchanged skipping 2022/04/20 06:10:57 INFO : one: Copied (server-side copy) to: one.bak 2022/04/20 06:10:57 INFO : one: Deleted 2022/04/20 06:10:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:10:58 DEBUG : one: md5 = a8479e7d12a29c22ab0077408ef85806 OK 2022/04/20 06:10:58 INFO : one: Copied (new) 2022/04/20 06:10:58 DEBUG : Waiting for deletions to finish 2022/04/20 06:10:58 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/04/20 06:10:58 INFO : three.txt: Deleted 2022/04/20 06:10:58 INFO : three.txt: Moved into backup dir 2022/04/20 06:10:59 DEBUG : dst/three.txt: md5 = 6e68a1178fbbd4129968c46c781d380d OK 2022/04/20 06:10:59 DEBUG : one.bak: Excluded 2022/04/20 06:10:59 DEBUG : three.txt.bak: Excluded 2022/04/20 06:10:59 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/04/20 06:10:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for checks to finish 2022/04/20 06:10:59 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:10:59 DEBUG : two: Unchanged skipping 2022/04/20 06:11:00 INFO : one: Copied (server-side copy) to: one.bak 2022/04/20 06:11:00 INFO : one: Deleted 2022/04/20 06:11:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst': Waiting for transfers to finish 2022/04/20 06:11:00 DEBUG : one: md5 = 7f39c0dd1e43a52b9590e94dcc8163a9 OK 2022/04/20 06:11:00 INFO : one: Copied (new) 2022/04/20 06:11:00 DEBUG : Waiting for deletions to finish 2022/04/20 06:11:00 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/04/20 06:11:01 INFO : three.txt: Deleted 2022/04/20 06:11:01 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (8.29s) === RUN TestSyncSuffix run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:11:03 DEBUG : dst/one: md5 = 7e877a0c213c712ff94de8504ac100b1 OK 2022/04/20 06:11:04 DEBUG : dst/two: md5 = dcc7eeb3972e822c15f96ffca08546fe OK 2022/04/20 06:11:04 DEBUG : dst/three.txt: md5 = c2c773d55050b523d7a517250020d8af OK 2022/04/20 06:11:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:11:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst.bin" 2022/04/20 06:11:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:11:05 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/04/20 06:11:05 INFO : one: Copied (server-side copy) to: one.bak 2022/04/20 06:11:06 INFO : one: Deleted 2022/04/20 06:11:06 DEBUG : one: md5 = c6e5ff2b038f37a909cc0ea17e5146a0 OK 2022/04/20 06:11:06 INFO : one: Copied (new) 2022/04/20 06:11:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:06 DEBUG : two: Unchanged skipping 2022/04/20 06:11:06 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/04/20 06:11:07 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/04/20 06:11:07 INFO : three.txt: Deleted 2022/04/20 06:11:07 DEBUG : three.txt: md5 = 019aa231d857516f001bda309cb58201 OK 2022/04/20 06:11:07 INFO : three.txt: Copied (new) 2022/04/20 06:11:08 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/04/20 06:11:08 INFO : one: Copied (server-side copy) to: one.bak 2022/04/20 06:11:09 INFO : one: Deleted 2022/04/20 06:11:10 DEBUG : one: md5 = 620d077ceddda12f3a130aeb6aac299f OK 2022/04/20 06:11:10 INFO : one: Copied (new) 2022/04/20 06:11:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:10 DEBUG : two: Unchanged skipping 2022/04/20 06:11:10 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/04/20 06:11:10 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2022/04/20 06:11:10 INFO : three.txt: Deleted 2022/04/20 06:11:11 DEBUG : three.txt: md5 = 223b93ec0d169f531106d3ae8f248ea9 OK 2022/04/20 06:11:11 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (9.50s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:11:13 DEBUG : dst/one: md5 = 5b0aa22147556d818022a61ac4d7336f OK 2022/04/20 06:11:13 DEBUG : dst/two: md5 = 6a37afd3f65c8d34a3261917c6698df5 OK 2022/04/20 06:11:13 DEBUG : dst/three.txt: md5 = d9defb3c9eecfa1d0b25c669fba153f7 OK 2022/04/20 06:11:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:11:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst.bin" 2022/04/20 06:11:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-junacoz0lewobiz2wakopif1/dst" 2022/04/20 06:11:14 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/04/20 06:11:15 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/04/20 06:11:15 INFO : one: Deleted 2022/04/20 06:11:15 DEBUG : one: md5 = ea31b4559d2e29485e4838b0a235ef40 OK 2022/04/20 06:11:15 INFO : one: Copied (new) 2022/04/20 06:11:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:15 DEBUG : two: Unchanged skipping 2022/04/20 06:11:15 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/04/20 06:11:16 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/04/20 06:11:16 INFO : three.txt: Deleted 2022/04/20 06:11:16 DEBUG : three.txt: md5 = 998c8609aa620ae6e48832b8a9593610 OK 2022/04/20 06:11:16 INFO : three.txt: Copied (new) 2022/04/20 06:11:17 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/04/20 06:11:17 INFO : one: Copied (server-side copy) to: one-2019-01-01 2022/04/20 06:11:17 INFO : one: Deleted 2022/04/20 06:11:18 DEBUG : one: md5 = 8d02bd85d7b3b9d1e33fa2f71c0ae70c OK 2022/04/20 06:11:18 INFO : one: Copied (new) 2022/04/20 06:11:18 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:18 DEBUG : two: Unchanged skipping 2022/04/20 06:11:18 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/04/20 06:11:18 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2022/04/20 06:11:18 INFO : three.txt: Deleted 2022/04/20 06:11:19 DEBUG : three.txt: md5 = 97b1b3692bbaeb35ae5d4aafcfd68dd8 OK 2022/04/20 06:11:19 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (7.84s) === RUN TestSyncUTFNorm run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:11:21 DEBUG : Testêé: md5 = 63e2d36579deadf1936ffb64ec32e18a OK 2022/04/20 06:11:21 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2022/04/20 06:11:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:11:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:11:21 DEBUG : Testêé: md5 = ae513ddc4a0a46a7b25f5de58c53747d OK 2022/04/20 06:11:21 INFO : Testêé: Copied (replaced existing) to: Testêé 2022/04/20 06:11:21 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (1.58s) === RUN TestSyncImmutable run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:11:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:11:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:11:24 DEBUG : existing: md5 = 6fea9c72cf4b6c1ffffa9988b23e0b4d OK 2022/04/20 06:11:24 INFO : existing: Copied (new) 2022/04/20 06:11:24 DEBUG : Waiting for deletions to finish 2022/04/20 06:11:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:11:24 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2022/04/20 06:11:24 ERROR : existing: Source and destination exist but do not match: immutable file modified 2022/04/20 06:11:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:11:24 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': not deleting files as there were IO errors 2022/04/20 06:11:24 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': not deleting directories as there were IO errors --- PASS: TestSyncImmutable (2.70s) === RUN TestSyncIgnoreCase run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:11:25 DEBUG : EXISTING: md5 = ec65c3276ee486e54f76abab62273384 OK 2022/04/20 06:11:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:11:25 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:25 DEBUG : existing: Unchanged skipping 2022/04/20 06:11:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:11:25 DEBUG : Waiting for deletions to finish 2022/04/20 06:11:25 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.62s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Soft run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" sync_test.go:1989: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" sync_test.go:1989: This test only runs on local --- PASS: TestMaxTransfer (0.56s) --- SKIP: TestMaxTransfer/Hard (0.09s) --- SKIP: TestMaxTransfer/Soft (0.32s) --- SKIP: TestMaxTransfer/Cautious (0.15s) === RUN TestSyncConcurrentDelete run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:11:27 DEBUG : both0: md5 = 28912e4976fdb6a5fa9f659724019001 OK 2022/04/20 06:11:27 DEBUG : only0: md5 = 61652a0755caeb85be74dd7dcb907dcb OK 2022/04/20 06:11:28 DEBUG : both1: md5 = 3d9fb4f650aeabde0384eeec6894a80a OK 2022/04/20 06:11:28 DEBUG : only1: md5 = 487b57fc934443766e3bdbd262605976 OK 2022/04/20 06:11:29 DEBUG : both2: md5 = 43a8a52edf4f67c977cf4444a6a7625f OK 2022/04/20 06:11:29 DEBUG : only2: md5 = 5f350b72930086357515e6fcde47e3a7 OK 2022/04/20 06:11:30 DEBUG : both3: md5 = c1541c13d09cb7a4a64e17fca05ce189 OK 2022/04/20 06:11:31 DEBUG : only3: md5 = 9c0f030bae4b3756193d08d54f3aa658 OK 2022/04/20 06:11:31 DEBUG : both4: md5 = cbb5c518fd9e9ad76e66cfe41fb58ead OK 2022/04/20 06:11:32 DEBUG : only4: md5 = fd141ccd4eb967cad60e132cba9d590f OK 2022/04/20 06:11:33 DEBUG : both5: md5 = e8b2475a031801a676182e81ab3d15f8 OK 2022/04/20 06:11:33 DEBUG : only5: md5 = 9081a4fe69d351bc743152d251bdd6a6 OK 2022/04/20 06:11:33 DEBUG : both6: md5 = fb80e5581372a5d25e7f3ed83563cb61 OK 2022/04/20 06:11:34 DEBUG : only6: md5 = ef6cbe1366d79ae25aeea3eb61946f10 OK 2022/04/20 06:11:34 DEBUG : both7: md5 = 0cf634d994a6bd40b0435276ec2fc594 OK 2022/04/20 06:11:34 DEBUG : only7: md5 = 13c934a87635376f0212b361d0971076 OK 2022/04/20 06:11:35 DEBUG : both8: md5 = faaaeec70c91205bc480f0e7b4d69843 OK 2022/04/20 06:11:36 DEBUG : only8: md5 = 30736d1abd05f4b48d7f6d9daa8bfa34 OK 2022/04/20 06:11:36 DEBUG : both9: md5 = a91f034aee06e2a76c36424cd454e3ca OK 2022/04/20 06:11:37 DEBUG : only9: md5 = c3586e2f8841a8f4a5e50a116e5ede9d OK 2022/04/20 06:11:38 DEBUG : both10: md5 = 8360d4de6b0899481215784340971271 OK 2022/04/20 06:11:38 DEBUG : only10: md5 = ac2000470c5e36950870c6deb9e7de85 OK 2022/04/20 06:11:38 DEBUG : both11: md5 = 1638cb2c1a57e2d3d07cb39842a66f88 OK 2022/04/20 06:11:39 DEBUG : only11: md5 = 119a4fcdca25918edfbc99085d70b6a7 OK 2022/04/20 06:11:39 DEBUG : both12: md5 = 95e23676d7b2c89a603a1e3ad8ba1793 OK 2022/04/20 06:11:41 DEBUG : only12: md5 = 41429766d493a71e60e7ca208437d47a OK 2022/04/20 06:11:42 DEBUG : both13: md5 = 7a8771d6d9296f1509b066d96674a92c OK 2022/04/20 06:11:42 DEBUG : only13: md5 = 6c6fe0156fcba292a2b02236ce00076c OK 2022/04/20 06:11:43 DEBUG : both14: md5 = c34a08d450f043bef216bf54b62fa21e OK 2022/04/20 06:11:43 DEBUG : only14: md5 = 366b07630643b1154b10156616dcd827 OK 2022/04/20 06:11:44 DEBUG : both15: md5 = 2fe34948c94a48269fac1f27a7845974 OK 2022/04/20 06:11:44 DEBUG : only15: md5 = e3c7e069a99634d4f2b79fc2c8bc8e5f OK 2022/04/20 06:11:44 DEBUG : both16: md5 = 427d38a73c2040df466cdb09edfc74f6 OK 2022/04/20 06:11:45 DEBUG : only16: md5 = 7802abd5ed652d77aa769543d637a900 OK 2022/04/20 06:11:45 DEBUG : both17: md5 = b1aa28fb99a83eedce739562dff900b6 OK 2022/04/20 06:11:46 DEBUG : only17: md5 = 6889c7d7e8c5c837698a97ea64d2d3b9 OK 2022/04/20 06:11:46 DEBUG : both18: md5 = a69900429a902699efcb82d45668c621 OK 2022/04/20 06:11:47 DEBUG : only18: md5 = 60bf286af47a27b85d2a12675e6834f6 OK 2022/04/20 06:11:47 DEBUG : both19: md5 = 5f466ba4ae7c3707704dc0e2c1d1e7c8 OK 2022/04/20 06:11:47 DEBUG : only19: md5 = 468a6e2f4151b0d0ca22fbbf49a3e0a6 OK 2022/04/20 06:11:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:11:50 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both0: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both1: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both10: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both11: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both12: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both13: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both14: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both15: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both16: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both17: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both18: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both19: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both2: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both3: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both4: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both5: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both6: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both7: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both8: Unchanged skipping 2022/04/20 06:11:50 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:11:50 DEBUG : both9: Unchanged skipping 2022/04/20 06:11:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:11:50 DEBUG : Waiting for deletions to finish 2022/04/20 06:11:50 INFO : only4: Deleted 2022/04/20 06:11:50 INFO : only3: Deleted 2022/04/20 06:11:50 INFO : only5: Deleted 2022/04/20 06:11:50 INFO : only15: Deleted 2022/04/20 06:11:50 INFO : only6: Deleted 2022/04/20 06:11:50 INFO : only8: Deleted 2022/04/20 06:11:50 INFO : only0: Deleted 2022/04/20 06:11:50 INFO : only1: Deleted 2022/04/20 06:11:51 INFO : only10: Deleted 2022/04/20 06:11:51 INFO : only11: Deleted 2022/04/20 06:11:51 INFO : only12: Deleted 2022/04/20 06:11:51 INFO : only14: Deleted 2022/04/20 06:11:51 INFO : only18: Deleted 2022/04/20 06:11:51 INFO : only13: Deleted 2022/04/20 06:11:51 INFO : only2: Deleted 2022/04/20 06:11:51 INFO : only17: Deleted 2022/04/20 06:11:51 INFO : only7: Deleted 2022/04/20 06:11:51 INFO : only9: Deleted 2022/04/20 06:11:52 INFO : only16: Deleted 2022/04/20 06:11:52 INFO : only19: Deleted 2022/04/20 06:11:52 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (30.00s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1'", Local "Local file system at /tmp/rclone2774870069", Modify Window "1ns" 2022/04/20 06:11:57 DEBUG : both0: md5 = 03c37ea5ec152c3f812c2ae386fa6924 OK 2022/04/20 06:11:58 DEBUG : only0: md5 = 7766db311ea10be156505c4432eee8d9 OK 2022/04/20 06:11:58 DEBUG : both1: md5 = c6fbb0d5d7073a2cdb054421b6fc0520 OK 2022/04/20 06:11:58 DEBUG : only1: md5 = 0f55ba808c2703bd55851ab825c5bcfa OK 2022/04/20 06:11:59 DEBUG : both2: md5 = aa0039ee4f1f9075a425e518546dd17e OK 2022/04/20 06:11:59 DEBUG : only2: md5 = 5d55b511c05375caf4e9b48b72e926c0 OK 2022/04/20 06:11:59 DEBUG : both3: md5 = 2bbe69d24d908a1eef148ed490c8a5d7 OK 2022/04/20 06:11:59 DEBUG : only3: md5 = 738800faa66bb72127b62dc005bbf6be OK 2022/04/20 06:12:00 DEBUG : both4: md5 = 25285d30f1736d4098e948c2e98c8464 OK 2022/04/20 06:12:00 DEBUG : only4: md5 = 2438f0de0aa191179e164972a2028722 OK 2022/04/20 06:12:00 DEBUG : both5: md5 = d6836b98454aa3f9f4de08ebba088af6 OK 2022/04/20 06:12:01 DEBUG : only5: md5 = 689c0486ed7ab791f6a2c0eb7ac0ace1 OK 2022/04/20 06:12:01 DEBUG : both6: md5 = 0f2ba384ca73b08a7fcec5017d36d2e4 OK 2022/04/20 06:12:01 DEBUG : only6: md5 = e5b2b4d26f04f31679f8c098709834f4 OK 2022/04/20 06:12:02 DEBUG : both7: md5 = bb900636d46aa341b73a74c0ab9227ed OK 2022/04/20 06:12:03 DEBUG : only7: md5 = 31613403d3300ee77734e26d96122d34 OK 2022/04/20 06:12:03 DEBUG : both8: md5 = f76cebe9babb1e005a46e383cd7956d1 OK 2022/04/20 06:12:03 DEBUG : only8: md5 = 01de0a2e6f3f0e8b2ca7a6af27a72c9d OK 2022/04/20 06:12:03 DEBUG : both9: md5 = 874244f29bd8cbef5ca0e32249ced3ca OK 2022/04/20 06:12:04 DEBUG : only9: md5 = 50b802c86e39fd2c668ccd858bb1833b OK 2022/04/20 06:12:05 DEBUG : both10: md5 = ba72c4c277bd36c477da724848d4aa60 OK 2022/04/20 06:12:05 DEBUG : only10: md5 = 77b3470feb806457e8bf130f19109490 OK 2022/04/20 06:12:05 DEBUG : both11: md5 = 7b4fa699dd156b73444f2e6538c4fe16 OK 2022/04/20 06:12:05 DEBUG : only11: md5 = e08e93cb4d93276018b06f3019e7a00c OK 2022/04/20 06:12:06 DEBUG : both12: md5 = a15b66eb95e3a76360d4082f7bf779a3 OK 2022/04/20 06:12:06 DEBUG : only12: md5 = 71754079898be558c441c03a0abdb830 OK 2022/04/20 06:12:07 DEBUG : both13: md5 = 1274de489f128c54d2787ab85d023fe6 OK 2022/04/20 06:12:07 DEBUG : only13: md5 = 41e1f772450ee43436dc07f4f2c57f24 OK 2022/04/20 06:12:07 DEBUG : both14: md5 = 8376b1f81eae26307735ab7634c29f58 OK 2022/04/20 06:12:08 DEBUG : only14: md5 = cb36fd0d6e60787e782aa2bf8f01c0a1 OK 2022/04/20 06:12:08 DEBUG : both15: md5 = 7852111d850e819d2f8652f152e72548 OK 2022/04/20 06:12:08 DEBUG : only15: md5 = 7cc0185f53f181126c31ade0f3763afe OK 2022/04/20 06:12:09 DEBUG : both16: md5 = 9329d640f7dd2f50b3c9e6760f0bf835 OK 2022/04/20 06:12:09 DEBUG : only16: md5 = c1f137ef5ed8b924937cd2eb5dc7e84a OK 2022/04/20 06:12:09 DEBUG : both17: md5 = 82036f7f4f12021f9f9528f06a126179 OK 2022/04/20 06:12:10 DEBUG : only17: md5 = 6361402da380dec82abea8b3d47e8c4e OK 2022/04/20 06:12:10 DEBUG : both18: md5 = 71d3f906b8dd95be99456ba50f53cce0 OK 2022/04/20 06:12:10 DEBUG : only18: md5 = 4cb01c6b42a722b9396ef0b35991254b OK 2022/04/20 06:12:11 DEBUG : both19: md5 = d2964465fe83164a40d587e5dda71936 OK 2022/04/20 06:12:11 DEBUG : only19: md5 = b2b522acd6178daf5483f75e3279598d OK 2022/04/20 06:12:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for checks to finish 2022/04/20 06:12:13 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both11: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both10: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both0: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both1: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both12: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both13: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both14: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both15: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both16: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both17: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both18: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both19: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both3: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both2: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both4: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both5: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both6: Unchanged skipping 2022/04/20 06:12:13 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2022/04/20 06:12:13 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both7: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both8: Unchanged skipping 2022/04/20 06:12:13 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2022/04/20 06:12:13 DEBUG : both9: Unchanged skipping 2022/04/20 06:12:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Waiting for transfers to finish 2022/04/20 06:12:13 DEBUG : only10: md5 = c5d1ac479db82f290443f755cf85ba2e OK 2022/04/20 06:12:13 INFO : only10: Copied (replaced existing) 2022/04/20 06:12:14 DEBUG : only1: md5 = f929618b8e8e975da82d55911babe10f OK 2022/04/20 06:12:14 INFO : only1: Copied (replaced existing) 2022/04/20 06:12:14 DEBUG : only11: md5 = a88cf3af67c88ee9ee1a73b1e40ac9f7 OK 2022/04/20 06:12:14 INFO : only11: Copied (replaced existing) 2022/04/20 06:12:14 DEBUG : only12: md5 = 9538b3a61ef3598da424d01416fab6c7 OK 2022/04/20 06:12:14 INFO : only12: Copied (replaced existing) 2022/04/20 06:12:14 DEBUG : only0: md5 = d05725a20ce076d40798532b68318d4f OK 2022/04/20 06:12:14 INFO : only0: Copied (replaced existing) 2022/04/20 06:12:14 DEBUG : only13: md5 = 38d591061c9bf71bf0838d494eb9670c OK 2022/04/20 06:12:14 INFO : only13: Copied (replaced existing) 2022/04/20 06:12:14 DEBUG : only14: md5 = fd7ef6a8440dedf3e18b31464622db1a OK 2022/04/20 06:12:14 INFO : only14: Copied (replaced existing) 2022/04/20 06:12:14 DEBUG : only16: md5 = e842a2eb087a691d22f0c53a9c72d7fe OK 2022/04/20 06:12:14 INFO : only16: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only15: md5 = 3bb0104a151bc897d12c3a413a66bc36 OK 2022/04/20 06:12:15 INFO : only15: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only17: md5 = c93dae5495708086fec0b15f2dd930e8 OK 2022/04/20 06:12:15 INFO : only17: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only18: md5 = 4e81338752c8d109c5836ef1b7f0f02e OK 2022/04/20 06:12:15 INFO : only18: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only3: md5 = c4819e89f95f324b447114aa90cfa5e6 OK 2022/04/20 06:12:15 INFO : only3: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only19: md5 = 21a15d3c81f70127b9862e7e0ad47e0e OK 2022/04/20 06:12:15 INFO : only19: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only2: md5 = ecacb0949f5cb11aa06c41b1ef5e6d6a OK 2022/04/20 06:12:15 INFO : only2: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only4: md5 = 229f15114fa2137b4b36377dd805bbfb OK 2022/04/20 06:12:15 INFO : only4: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only5: md5 = 89ea2b4a545b70a31c515513311c58cb OK 2022/04/20 06:12:15 INFO : only5: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only7: md5 = aefe1582f7e54d2af8da93a23d876a3c OK 2022/04/20 06:12:15 INFO : only7: Copied (replaced existing) 2022/04/20 06:12:15 DEBUG : only6: md5 = 062cd88afa92287dd0f57d36f33bb3e5 OK 2022/04/20 06:12:15 INFO : only6: Copied (replaced existing) 2022/04/20 06:12:16 DEBUG : only8: md5 = d5089a2b5c52439794702331f9430a90 OK 2022/04/20 06:12:16 INFO : only8: Copied (replaced existing) 2022/04/20 06:12:16 DEBUG : only9: md5 = 4e420f0ed073a032777aa9370a8f1548 OK 2022/04/20 06:12:16 INFO : only9: Copied (replaced existing) 2022/04/20 06:12:16 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (28.75s) PASS 2022/04/20 06:12:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-junacoz0lewobiz2wakopif1': Purge remote 2022/04/20 06:12:25 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 4m9.587495809s (try 1/5)