"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2025/04/19 04:44:46 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya" 2025/04/19 04:44:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/19 04:44:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya.bin" 2025/04/19 04:44:47 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya.bin: Auto set use_segments_container to true 2025/04/19 04:44:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya" 2025/04/19 04:44:53 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya: Auto set use_segments_container to true 2025/04/19 04:44:58 DEBUG : Creating backend with remote "/tmp/rclone8866414" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.05s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:44:58 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:44:58 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/04/19 04:44:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:44:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.59s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:44:59 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/19 04:44:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:44:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:44:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:44:59 DEBUG : sub dir/hello world: md5 = 2bc7bbe55551b924873da57267edde53 OK 2025/04/19 04:44:59 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:44:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (1.40s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.19s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.10s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:00 DEBUG : Creating backend with remote "/non-existing" 2025/04/19 04:45:00 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/04/19 04:45:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.24s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:06 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:45:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:06 DEBUG : sub dir/hello world: md5 = e68011aab7f6b0a25656de392e9ede31 OK 2025/04/19 04:45:06 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyNoTraverse (5.87s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:06 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Running all checks before starting transfers 2025/04/19 04:45:06 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:45:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:06 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Checks finished, now starting transfers 2025/04/19 04:45:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:07 DEBUG : sub dir/hello world: md5 = 51baa8ac3a229dce3e5286f01fb1e2e7 OK 2025/04/19 04:45:07 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyCheckFirst (1.03s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:07 ERROR : Ignoring --no-traverse with sync 2025/04/19 04:45:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:45:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:08 DEBUG : sub dir/hello world: md5 = 08138289d221dec5ca65bfc10d614612 OK 2025/04/19 04:45:08 INFO : sub dir/hello world: Copied (new) 2025/04/19 04:45:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncNoTraverse (1.02s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:08 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/04/19 04:45:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:09 DEBUG : hello world2: md5 = cd8bb57c1f50476e24bec888d878a57a OK 2025/04/19 04:45:09 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyWithDepth (1.45s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:10 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 04:45:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:15 DEBUG : potato2: md5 = 8e928708c602c5dc608bddc882ad3af1 OK 2025/04/19 04:45:15 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (16.21s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:31 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 04:45:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:37 DEBUG : potato2: md5 = 4a33af34ba7aac7894825cfb9feca1a2 OK 2025/04/19 04:45:37 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (21.73s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:48 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/04/19 04:45:48 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/19 04:45:48 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/04/19 04:45:48 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/19 04:45:48 INFO : sub dir: Making directory 2025/04/19 04:45:48 INFO : sub dir2: Making directory 2025/04/19 04:45:48 INFO : sub dir2/sub sub dir2: Making directory 2025/04/19 04:45:48 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:45:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:48 DEBUG : sub dir/hello world: md5 = 11c281738eda68e98800109b58379277 OK 2025/04/19 04:45:48 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2025/04/19 04:45:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (0.99s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:49 INFO : sub dir2: Making directory 2025/04/19 04:45:49 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/04/19 04:45:49 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/19 04:45:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:45:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:49 DEBUG : sub dir/hello world: md5 = 25903219c5e692b12cc6de8cd104ddae OK 2025/04/19 04:45:49 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (0.86s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:50 DEBUG : sub dir2: Making directory with metadata 2025/04/19 04:45:50 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/19 04:45:50 INFO : sub dir: Making directory 2025/04/19 04:45:50 INFO : sub dir2: Making directory 2025/04/19 04:45:50 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:45:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:50 DEBUG : sub dir/hello world: md5 = fdbd01e8fa5a9c02b049dc1c57277fa1 OK 2025/04/19 04:45:50 INFO : sub dir/hello world: Copied (new) 2025/04/19 04:45:50 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/04/19 04:45:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/04/19 04:45:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (0.99s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.20s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:51 INFO : sub dir2: Making directory 2025/04/19 04:45:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:45:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:51 DEBUG : sub dir/hello world: md5 = ead960d763ee384b9da902954f4301ea OK 2025/04/19 04:45:51 INFO : sub dir/hello world: Copied (new) 2025/04/19 04:45:51 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (0.93s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:52 DEBUG : sub dir2: Making directory with metadata 2025/04/19 04:45:52 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/19 04:45:52 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/19 04:45:52 INFO : sub dir: Making directory 2025/04/19 04:45:52 INFO : sub dir2: Making directory 2025/04/19 04:45:52 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:45:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:52 DEBUG : sub dir/hello world: md5 = 8d24fededa58155c5144949d984cfb2b OK 2025/04/19 04:45:52 INFO : sub dir/hello world: Copied (new) 2025/04/19 04:45:52 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/04/19 04:45:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (0.90s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.23s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:53 INFO : sub dir2: Making directory 2025/04/19 04:45:53 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:45:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:45:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:45:53 DEBUG : sub dir/hello world: md5 = 8eae840510e26b93168eb2441447a51e OK 2025/04/19 04:45:53 INFO : sub dir/hello world: Copied (new) 2025/04/19 04:45:53 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (0.81s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:45:54 DEBUG : sub dir/hello world: md5 = 608dfbff5e1064d17ef1ea09118d9c9f OK 2025/04/19 04:45:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-diyabaw7dilo" 2025/04/19 04:45:54 DEBUG : Config file has changed externally - reloading 2025/04/19 04:45:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-diyabaw7dilo.bin" 2025/04/19 04:45:55 DEBUG : Swift container crypt path rclone-test-diyabaw7dilo.bin: Auto set use_segments_container to true 2025/04/19 04:46:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-diyabaw7dilo" 2025/04/19 04:46:01 DEBUG : Swift container crypt path rclone-test-diyabaw7dilo: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya' -> Encrypted drive 'TestCryptSwift:rclone-test-diyabaw7dilo' 2025/04/19 04:46:06 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:46:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-diyabaw7dilo': Waiting for checks to finish 2025/04/19 04:46:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-diyabaw7dilo': Waiting for transfers to finish 2025/04/19 04:46:22 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:46:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-diyabaw7dilo': Purge remote 2025/04/19 04:46:22 DEBUG : Waiting for deletions to finish 2025/04/19 04:46:27 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (33.66s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:46:28 DEBUG : sub dir/hello world: md5 = 9371c12b66ab51d40be01ab3dd3615a9 OK 2025/04/19 04:46:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:46:28 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/19 04:46:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:46:28 DEBUG : sub dir/hello world: md5 = 3c5baa387491bd801a68856af83ffd73 OK 2025/04/19 04:46:28 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyOverSelf (1.69s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:46:29 DEBUG : sub dir/hello world: md5 = bbd742ebe2189573896c99d68eb37cc9 OK 2025/04/19 04:46:29 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-luxunih1puhu" 2025/04/19 04:46:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-luxunih1puhu.bin" 2025/04/19 04:46:30 DEBUG : Swift container crypt path rclone-test-luxunih1puhu.bin: Auto set use_segments_container to true 2025/04/19 04:46:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-luxunih1puhu" 2025/04/19 04:46:36 DEBUG : Swift container crypt path rclone-test-luxunih1puhu: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya' -> Encrypted drive 'TestCryptSwift:rclone-test-luxunih1puhu' 2025/04/19 04:46:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:46:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luxunih1puhu': Waiting for checks to finish 2025/04/19 04:46:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luxunih1puhu': Waiting for transfers to finish 2025/04/19 04:46:52 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:46:58 DEBUG : sub dir/hello world: md5 = b87fcab777a4d12a0d2469a4390117d0 OK 2025/04/19 04:46:58 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/19 04:46:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luxunih1puhu': Waiting for checks to finish 2025/04/19 04:46:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luxunih1puhu': Waiting for transfers to finish 2025/04/19 04:47:09 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:47:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luxunih1puhu': Purge remote 2025/04/19 04:47:14 DEBUG : Waiting for deletions to finish 2025/04/19 04:47:24 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (56.01s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:47:25 DEBUG : sub dir/hello world: md5 = 8be04c1f6a0c4d718655a01cba18aaaa OK 2025/04/19 04:47:26 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/19 04:47:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:47:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:47:26 DEBUG : sub dir/hello world: md5 = 56ea05f07afdd748af60e36d7a24c794 OK 2025/04/19 04:47:26 INFO : sub dir/hello world: Copied (replaced existing) 2025/04/19 04:47:26 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestMoveOverSelf (1.46s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:47:27 DEBUG : sub dir/hello world: md5 = 6f25b4bddcf9b0b67221f23288da63b3 OK 2025/04/19 04:47:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zumadir6puca" 2025/04/19 04:47:27 DEBUG : Config file has changed externally - reloading 2025/04/19 04:47:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zumadir6puca.bin" 2025/04/19 04:47:27 DEBUG : Swift container crypt path rclone-test-zumadir6puca.bin: Auto set use_segments_container to true 2025/04/19 04:47:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zumadir6puca" 2025/04/19 04:47:33 DEBUG : Swift container crypt path rclone-test-zumadir6puca: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya' -> Encrypted drive 'TestCryptSwift:rclone-test-zumadir6puca' 2025/04/19 04:47:40 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:47:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zumadir6puca': Waiting for checks to finish 2025/04/19 04:47:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zumadir6puca': Waiting for transfers to finish 2025/04/19 04:47:50 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:47:56 DEBUG : sub dir/hello world: md5 = a4020c8b5fc9f3012f3aa89c62711ece OK 2025/04/19 04:47:56 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/19 04:47:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zumadir6puca': Waiting for checks to finish 2025/04/19 04:47:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zumadir6puca': Waiting for transfers to finish 2025/04/19 04:48:11 INFO : sub dir/hello world: Copied (server-side copy) 2025/04/19 04:48:11 INFO : sub dir/hello world: Deleted 2025/04/19 04:48:12 DEBUG : sub dir/hello world: md5 = 2d0d7de1240961555fb975bbcc828549 OK 2025/04/19 04:48:12 DEBUG : testing file moves 2025/04/19 04:48:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zumadir6puca': Waiting for checks to finish 2025/04/19 04:48:12 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/04/19 04:48:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zumadir6puca': Waiting for transfers to finish 2025/04/19 04:48:23 INFO : sub dir/hello world: Copied (server-side copy) 2025/04/19 04:48:23 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zumadir6puca': Purge remote 2025/04/19 04:48:23 DEBUG : Waiting for deletions to finish 2025/04/19 04:48:28 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (62.34s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:29 DEBUG : sub dir/hello world: md5 = 84e70f8b42b6154130f0ce7f0f331997 OK 2025/04/19 04:48:29 ERROR : : error listing: directory not found 2025/04/19 04:48:29 INFO : Local file system at /tmp/rclone8866414: Making directory 2025/04/19 04:48:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyAfterDelete (1.29s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:30 DEBUG : sub dir/hello world: md5 = 11b7c093657511034159d56cf3e8b14c OK 2025/04/19 04:48:31 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:48:31 DEBUG : Local file system at /tmp/rclone8866414: Waiting for checks to finish 2025/04/19 04:48:31 DEBUG : Local file system at /tmp/rclone8866414: Waiting for transfers to finish 2025/04/19 04:48:31 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/19 04:48:31 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyRedownload (1.40s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:32 DEBUG : check sum: Need to transfer - File not found at Destination 2025/04/19 04:48:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:32 DEBUG : check sum: md5 = cb07e092bf22181d864179e9ba820d67 OK 2025/04/19 04:48:32 INFO : check sum: Copied (new) 2025/04/19 04:48:32 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:32 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/04/19 04:48:32 DEBUG : check sum: Size of src and dst objects identical 2025/04/19 04:48:32 DEBUG : check sum: Unchanged skipping 2025/04/19 04:48:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:32 DEBUG : Waiting for deletions to finish 2025/04/19 04:48:32 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (2.03s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:34 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/04/19 04:48:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:34 DEBUG : sizeonly: md5 = 8b3f1699560d0fe9dbef1afe67260a30 OK 2025/04/19 04:48:34 INFO : sizeonly: Copied (new) 2025/04/19 04:48:34 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:35 DEBUG : sizeonly: Sizes identical 2025/04/19 04:48:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:35 DEBUG : sizeonly: Unchanged skipping 2025/04/19 04:48:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:35 DEBUG : Waiting for deletions to finish 2025/04/19 04:48:35 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncSizeOnly (2.04s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:36 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/04/19 04:48:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:36 DEBUG : ignore-size: md5 = b9d4312855227b515ae720b7f7454c94 OK 2025/04/19 04:48:36 INFO : ignore-size: Copied (new) 2025/04/19 04:48:36 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:37 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:48:37 DEBUG : ignore-size: Unchanged skipping 2025/04/19 04:48:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:37 DEBUG : Waiting for deletions to finish 2025/04/19 04:48:37 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (1.97s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:38 DEBUG : existing: md5 = 3432bcf9e9c80f5fc198ab867394894b OK 2025/04/19 04:48:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:39 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:48:39 DEBUG : existing: Unchanged skipping 2025/04/19 04:48:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:39 DEBUG : Waiting for deletions to finish 2025/04/19 04:48:39 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:39 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/04/19 04:48:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:39 DEBUG : existing: md5 = d10ab4ea55c7fcdda75b85f4e901ce02 OK 2025/04/19 04:48:39 INFO : existing: Copied (replaced existing) 2025/04/19 04:48:39 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (2.36s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:40 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/19 04:48:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:40 DEBUG : existing: md5 = f3dfe1ba351afefc98ea88c4e324156b OK 2025/04/19 04:48:40 INFO : existing: Copied (new) 2025/04/19 04:48:40 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:41 DEBUG : existing: Destination exists, skipping 2025/04/19 04:48:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:41 DEBUG : Waiting for deletions to finish 2025/04/19 04:48:41 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (1.34s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:48:47 DEBUG : b/potato: md5 = d8d8667ebe781f40f9cd575393b55e35 OK 2025/04/19 04:48:47 DEBUG : c/non empty space: md5 = 7502ce1102e315712cb358e80fab44f0 OK 2025/04/19 04:48:47 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/04/19 04:48:47 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/19 04:48:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:48:47 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:48:47 DEBUG : c/non empty space: Unchanged skipping 2025/04/19 04:48:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:48:53 DEBUG : a/potato2: md5 = 526c152640709f42a59cd1cf29445a50 OK 2025/04/19 04:48:53 INFO : a/potato2: Copied (new) 2025/04/19 04:48:53 DEBUG : Waiting for deletions to finish 2025/04/19 04:48:58 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (28.00s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:49:15 DEBUG : empty space: md5 = 34640f96fca110d1b3cfe81f630e213f OK 2025/04/19 04:49:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:49:15 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/04/19 04:49:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:49:15 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/04/19 04:49:15 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:49:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:49:25 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/04/19 04:49:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:49:30 DEBUG : empty space: md5 = 59e136ed01bc96cdb3c2aa58ed3f3591 OK 2025/04/19 04:49:30 INFO : empty space: Copied (replaced existing) 2025/04/19 04:49:30 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (26.85s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:1016: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.10s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:49:37 DEBUG : foo: md5 = 223c55d9f404efcf27e918966ed2bf91 OK 2025/04/19 04:49:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:49:37 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/04/19 04:49:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:49:38 DEBUG : foo: md5 = abc29de0499fd2f934c5ae22d0414df0 OK 2025/04/19 04:49:38 INFO : foo: Copied (replaced existing) 2025/04/19 04:49:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (2.25s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:49:44 DEBUG : empty space: md5 = 7dc7fc3c75933b65e4c51f79f5c1120f OK 2025/04/19 04:49:44 DEBUG : potato: Need to transfer - File not found at Destination 2025/04/19 04:49:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:49:49 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:49:49 DEBUG : empty space: Unchanged skipping 2025/04/19 04:49:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:49:50 DEBUG : potato: md5 = f976272473c47298deea534abc9d0f38 OK 2025/04/19 04:49:50 INFO : potato: Copied (new) 2025/04/19 04:49:50 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (27.32s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:50:11 DEBUG : potato: md5 = 8dcb98f3f8c134c5feba3a970e83d6a6 OK 2025/04/19 04:50:11 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/04/19 04:50:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:50:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:50:16 DEBUG : potato: md5 = a9fcd58ff4af7a0b786e8c1f8c025d7a OK 2025/04/19 04:50:16 INFO : potato: Copied (replaced existing) 2025/04/19 04:50:16 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (16.33s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:50:27 DEBUG : potato: md5 = dc2f273cf416e2d993a8c8403f6e53a6 OK 2025/04/19 04:50:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:50:38 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2025/04/19 04:50:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:50:43 DEBUG : potato: md5 = ca384948ef5705be29f8421ec3cb59e3 OK 2025/04/19 04:50:43 INFO : potato: Copied (replaced existing) 2025/04/19 04:50:43 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (31.66s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:50:59 DEBUG : potato: md5 = df82b04174c780d51c4837325fd65a42 OK 2025/04/19 04:51:04 DEBUG : empty space: md5 = e78993ae6cb900a8eefe1ced86b104cd OK 2025/04/19 04:51:05 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:51:09 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 04:51:09 DEBUG : empty space: Unchanged skipping 2025/04/19 04:51:09 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/04/19 04:51:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:51:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:51:09 DEBUG : Waiting for deletions to finish 2025/04/19 04:51:09 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (36.63s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:51:36 DEBUG : potato: md5 = 9317edcd02af822bcc5d1cf8726419f7 OK 2025/04/19 04:51:41 DEBUG : empty space: md5 = 6232dab849bd263c8843dbf442a45237 OK 2025/04/19 04:51:46 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 04:51:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:51:51 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:51:51 DEBUG : empty space: Unchanged skipping 2025/04/19 04:51:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:51:51 DEBUG : potato2: md5 = 5cba84e6aa2e0cee863ed04a10d3002a OK 2025/04/19 04:51:51 INFO : potato2: Copied (new) 2025/04/19 04:51:51 DEBUG : Waiting for deletions to finish 2025/04/19 04:51:56 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (47.55s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:52:23 DEBUG : b/potato: md5 = 504789c894fd734a0f3868a3e6db3b53 OK 2025/04/19 04:52:23 DEBUG : c/non empty space: md5 = 782f141881993b327258a78e709ab8c6 OK 2025/04/19 04:52:23 INFO : d: Making directory 2025/04/19 04:52:23 INFO : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2025/04/19 04:52:24 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/19 04:52:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:52:24 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:52:24 DEBUG : c/non empty space: Unchanged skipping 2025/04/19 04:52:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:52:29 DEBUG : a/potato2: md5 = 1c8383e4e34eb83b0331df8db5dc892c OK 2025/04/19 04:52:29 INFO : a/potato2: Copied (new) 2025/04/19 04:52:29 DEBUG : Waiting for deletions to finish 2025/04/19 04:52:39 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (32.08s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:52:55 DEBUG : b/potato: md5 = b8e89d60389e47e7b250943fe22fe893 OK 2025/04/19 04:52:55 DEBUG : c/non empty space: md5 = b6b4c2d971c7e5065d8d1b757cdee3bc OK 2025/04/19 04:52:55 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/04/19 04:52:56 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/19 04:52:56 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:52:56 DEBUG : c/non empty space: Unchanged skipping 2025/04/19 04:52:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:52:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:53:01 DEBUG : a/potato2: md5 = 7b6c07350a3c5d3a17974eae8a585b88 OK 2025/04/19 04:53:01 INFO : a/potato2: Copied (new) 2025/04/19 04:53:01 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': not deleting files as there were IO errors 2025/04/19 04:53:01 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (32.02s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:53:27 DEBUG : potato: md5 = c7abdc358f166bd6b19d6eb08303d0b2 OK 2025/04/19 04:53:32 DEBUG : empty space: md5 = 2bb60fcb7446eca88f77f7f4d544c7e7 OK 2025/04/19 04:53:33 DEBUG : Waiting for deletions to finish 2025/04/19 04:53:33 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 04:53:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:53:38 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:53:38 DEBUG : empty space: Unchanged skipping 2025/04/19 04:53:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:53:38 DEBUG : potato2: md5 = a8d202da3a7072c714a665d7fb5e09eb OK 2025/04/19 04:53:38 INFO : potato2: Copied (new) 2025/04/19 04:53:43 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (36.61s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:54:04 DEBUG : potato: md5 = 76fa5fe729acf4f0fb14deb0247723a4 OK 2025/04/19 04:54:09 DEBUG : empty space: md5 = 387d417376a67d4f58870e5c08a935ab OK 2025/04/19 04:54:09 DEBUG : Waiting for deletions to finish 2025/04/19 04:54:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:54:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:54:15 INFO : potato: Deleted 2025/04/19 04:54:15 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 04:54:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:54:20 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:54:20 DEBUG : empty space: Unchanged skipping 2025/04/19 04:54:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:54:20 DEBUG : potato2: md5 = 640c7109554b67d1121491cb31060efc OK 2025/04/19 04:54:20 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (37.02s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:54:41 DEBUG : potato: md5 = 9f5cc0eafeea3b2562bf62174023b2dd OK 2025/04/19 04:54:41 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 04:54:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:54:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:54:46 DEBUG : potato2: md5 = e3f83f859e36140e1203e1d37d512c2b OK 2025/04/19 04:54:46 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (36.61s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:55:17 DEBUG : potato2: md5 = a0e6428e4281d493bebf053af75e839c OK 2025/04/19 04:55:23 DEBUG : empty space: md5 = ce46a526a41c0713cf9c62addc51e84d OK 2025/04/19 04:55:23 DEBUG : enormous: Excluded (Size Filter) 2025/04/19 04:55:23 DEBUG : enormous: Excluded 2025/04/19 04:55:23 DEBUG : potato2: Excluded (Size Filter) 2025/04/19 04:55:23 DEBUG : potato2: Excluded 2025/04/19 04:55:23 DEBUG : potato2: Excluded (Size Filter) 2025/04/19 04:55:23 DEBUG : potato2: Excluded 2025/04/19 04:55:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:55:28 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:55:28 DEBUG : empty space: Unchanged skipping 2025/04/19 04:55:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:55:28 DEBUG : Waiting for deletions to finish 2025/04/19 04:55:28 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:55:38 DEBUG : enormous: Excluded (Size Filter) 2025/04/19 04:55:38 DEBUG : enormous: Excluded 2025/04/19 04:55:38 DEBUG : potato2: Excluded (Size Filter) 2025/04/19 04:55:38 DEBUG : potato2: Excluded 2025/04/19 04:55:38 DEBUG : potato2: Excluded (Size Filter) 2025/04/19 04:55:38 DEBUG : potato2: Excluded 2025/04/19 04:55:38 DEBUG : Local file system at /tmp/rclone8866414: Waiting for checks to finish 2025/04/19 04:55:38 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:55:38 DEBUG : empty space: Unchanged skipping 2025/04/19 04:55:38 DEBUG : Local file system at /tmp/rclone8866414: Waiting for transfers to finish 2025/04/19 04:55:38 DEBUG : Waiting for deletions to finish 2025/04/19 04:55:38 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncWithExclude (42.15s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:56:00 DEBUG : potato2: md5 = 2fdb88e332c1810de6ee4ee430f0578e OK 2025/04/19 04:56:05 DEBUG : empty space: md5 = 6ae0cf1cbb682efb94733c1ef80697d6 OK 2025/04/19 04:56:10 DEBUG : enormous: md5 = a2a116b15b5e97e1ff32a67b3f148718 OK 2025/04/19 04:56:15 DEBUG : enormous: Excluded (Size Filter) 2025/04/19 04:56:15 DEBUG : enormous: Excluded 2025/04/19 04:56:15 DEBUG : potato2: Excluded (Size Filter) 2025/04/19 04:56:15 DEBUG : potato2: Excluded 2025/04/19 04:56:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:56:21 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:56:21 DEBUG : empty space: Unchanged skipping 2025/04/19 04:56:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:56:21 DEBUG : Waiting for deletions to finish 2025/04/19 04:56:26 INFO : enormous: Deleted 2025/04/19 04:56:31 INFO : potato2: Deleted 2025/04/19 04:56:31 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:56:36 DEBUG : Local file system at /tmp/rclone8866414: Waiting for checks to finish 2025/04/19 04:56:41 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:56:41 DEBUG : empty space: Unchanged skipping 2025/04/19 04:56:41 DEBUG : Local file system at /tmp/rclone8866414: Waiting for transfers to finish 2025/04/19 04:56:41 DEBUG : Waiting for deletions to finish 2025/04/19 04:56:41 INFO : enormous: Deleted 2025/04/19 04:56:41 INFO : potato2: Deleted 2025/04/19 04:56:41 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (52.53s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:56:47 DEBUG : one: md5 = 579f43685b3e895c5984221847310a80 OK 2025/04/19 04:56:48 DEBUG : two: md5 = b60e99cfb9ddab7afcb87d211636845d OK 2025/04/19 04:56:53 DEBUG : three: md5 = be90da15ab5c42971d5d63591e422c66 OK 2025/04/19 04:56:54 DEBUG : four: md5 = dad8fc174dfaddf6d47c10af22378d37 OK 2025/04/19 04:56:54 DEBUG : five: Need to transfer - File not found at Destination 2025/04/19 04:56:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:56:54 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/04/19 04:56:54 DEBUG : one: Destination is newer than source, skipping 2025/04/19 04:56:54 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/04/19 04:56:54 DEBUG : three: Sizes identical 2025/04/19 04:56:54 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/04/19 04:56:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:56:54 DEBUG : two: md5 = c1f0f70a3c5e0eef30fdf73e31289474 OK 2025/04/19 04:56:54 INFO : two: Copied (replaced existing) 2025/04/19 04:56:54 DEBUG : four: md5 = 60e768926f96600bb61814158ed14f42 OK 2025/04/19 04:56:54 INFO : four: Copied (replaced existing) 2025/04/19 04:56:54 DEBUG : five: md5 = d671070f48d4461aaee7e23a752e41f9 OK 2025/04/19 04:56:54 INFO : five: Copied (new) 2025/04/19 04:56:54 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (18.91s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1466: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1466: Skipping test on non local remote --- PASS: TestSyncWithMaxDuration (0.00s) --- SKIP: TestSyncWithMaxDuration/Hard (0.00s) --- SKIP: TestSyncWithMaxDuration/Soft (0.00s) === RUN TestSyncWithTrackRenames run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2025/04/19 04:57:06 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Ignoring --track-renames as the source and destination do not have a common hash 2025/04/19 04:57:06 DEBUG : potato: Need to transfer - File not found at Destination 2025/04/19 04:57:06 DEBUG : yam: Need to transfer - File not found at Destination 2025/04/19 04:57:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:57:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:57:11 DEBUG : potato: md5 = 2be82c387e7e3259734dc06cfa644549 OK 2025/04/19 04:57:11 INFO : potato: Copied (new) 2025/04/19 04:57:12 DEBUG : yam: md5 = 104bdba7d0c174637228d0c9ac8824f4 OK 2025/04/19 04:57:12 INFO : yam: Copied (new) 2025/04/19 04:57:12 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:57:12 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Ignoring --track-renames as the source and destination do not have a common hash 2025/04/19 04:57:13 DEBUG : yaml: Need to transfer - File not found at Destination 2025/04/19 04:57:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:57:18 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:57:18 DEBUG : potato: Unchanged skipping 2025/04/19 04:57:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:57:18 DEBUG : yaml: md5 = e8491babec0cc134cb4d3f08ed4fe188 OK 2025/04/19 04:57:18 INFO : yaml: Copied (new) 2025/04/19 04:57:18 DEBUG : Waiting for deletions to finish 2025/04/19 04:57:28 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (38.37s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2025/04/19 04:57:44 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Making map for --track-renames 2025/04/19 04:57:44 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Finished making map for --track-renames 2025/04/19 04:57:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:57:44 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/19 04:57:44 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/04/19 04:57:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for renames to finish 2025/04/19 04:57:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:57:49 DEBUG : yam: md5 = cd29942785011c6ad2ea1afa8492458e OK 2025/04/19 04:57:49 INFO : yam: Copied (new) 2025/04/19 04:57:49 DEBUG : potato: md5 = 6f3328f9f89c6b842f28688016f74a47 OK 2025/04/19 04:57:49 INFO : potato: Copied (new) 2025/04/19 04:57:49 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:57:55 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Making map for --track-renames 2025/04/19 04:57:55 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Finished making map for --track-renames 2025/04/19 04:57:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:57:55 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:57:55 DEBUG : potato: Unchanged skipping 2025/04/19 04:57:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for renames to finish 2025/04/19 04:58:10 INFO : yam: Copied (server-side copy) to: yaml 2025/04/19 04:58:15 INFO : yam: Deleted 2025/04/19 04:58:15 INFO : yaml: Renamed from "yam" 2025/04/19 04:58:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:58:15 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (51.97s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2025/04/19 04:58:36 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Making map for --track-renames 2025/04/19 04:58:36 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Finished making map for --track-renames 2025/04/19 04:58:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:58:36 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/19 04:58:36 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/04/19 04:58:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for renames to finish 2025/04/19 04:58:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:58:42 DEBUG : potato: md5 = fb5ae723c647585421958a3e8d9de0ab OK 2025/04/19 04:58:42 INFO : potato: Copied (new) 2025/04/19 04:58:42 DEBUG : sub/yam: md5 = b7fabb3cefd8cb167b4bc26de47c9315 OK 2025/04/19 04:58:42 INFO : sub/yam: Copied (new) 2025/04/19 04:58:42 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:58:42 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Making map for --track-renames 2025/04/19 04:58:42 INFO : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Finished making map for --track-renames 2025/04/19 04:58:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:58:47 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 04:58:47 DEBUG : potato: Unchanged skipping 2025/04/19 04:58:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for renames to finish 2025/04/19 04:59:03 INFO : sub/yam: Copied (server-side copy) to: yam 2025/04/19 04:59:08 INFO : sub/yam: Deleted 2025/04/19 04:59:08 INFO : yam: Renamed from "sub/yam" 2025/04/19 04:59:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:59:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (47.93s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:59:24 DEBUG : Creating backend with remote "/tmp/rclone8866414/dir1" 2025/04/19 04:59:24 DEBUG : Config file has changed externally - reloading 2025/04/19 04:59:24 DEBUG : Creating backend with remote "/tmp/rclone8866414/dir2" 2025/04/19 04:59:24 DEBUG : Local file system at /tmp/rclone8866414/dir2: Using server-side directory move 2025/04/19 04:59:24 INFO : Local file system at /tmp/rclone8866414/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/19 04:59:24 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/04/19 04:59:24 INFO : file1.txt: Moved (server-side) 2025/04/19 04:59:24 DEBUG : Local file system at /tmp/rclone8866414/dir2: Waiting for checks to finish 2025/04/19 04:59:24 DEBUG : Local file system at /tmp/rclone8866414/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.10s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:59:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:59:24 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/04/19 04:59:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:59:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:59:24 DEBUG : sub dir/hello world: md5 = c7cbcc99b121b694b55aba634b805605 OK 2025/04/19 04:59:24 INFO : sub dir/hello world: Copied (new) 2025/04/19 04:59:24 INFO : sub dir/hello world: Deleted 2025/04/19 04:59:30 DEBUG : nested/sub dir/file: md5 = a5eea299fdbe8d0043747d2a9cc3a230 OK 2025/04/19 04:59:30 INFO : nested/sub dir/file: Copied (new) 2025/04/19 04:59:30 INFO : nested/sub dir/file: Deleted 2025/04/19 04:59:30 INFO : sub dir: Removing directory 2025/04/19 04:59:30 INFO : nested/sub dir: Removing directory 2025/04/19 04:59:30 INFO : nested: Removing directory 2025/04/19 04:59:30 DEBUG : Local file system at /tmp/rclone8866414: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (11.86s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:59:36 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/19 04:59:36 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/04/19 04:59:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:59:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:59:36 DEBUG : sub dir/hello world: md5 = 9f8b841a98ef4e08fbe60bad00fa1a73 OK 2025/04/19 04:59:36 INFO : sub dir/hello world: Copied (new) 2025/04/19 04:59:36 INFO : sub dir/hello world: Deleted 2025/04/19 04:59:41 DEBUG : nested/sub dir/file: md5 = bb9782eaf2dd4c65e8e750705302ca2d OK 2025/04/19 04:59:41 INFO : nested/sub dir/file: Copied (new) 2025/04/19 04:59:41 INFO : nested/sub dir/file: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (16.36s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:59:53 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/19 04:59:53 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/04/19 04:59:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:59:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:59:53 DEBUG : existing: md5 = d7f4225e0755e5351dbe54e625275fc8 OK 2025/04/19 04:59:53 INFO : existing: Copied (new) 2025/04/19 04:59:53 INFO : existing: Deleted 2025/04/19 04:59:53 DEBUG : existing-b: md5 = aaf95033ee634c4230757ebf71898337 OK 2025/04/19 04:59:53 INFO : existing-b: Copied (new) 2025/04/19 04:59:53 INFO : existing-b: Deleted 2025/04/19 04:59:53 DEBUG : existing: Destination exists, skipping 2025/04/19 04:59:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 04:59:53 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/04/19 04:59:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 04:59:53 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (1.93s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 04:59:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-rocazuc8cabi" 2025/04/19 04:59:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rocazuc8cabi.bin" 2025/04/19 04:59:55 DEBUG : Swift container crypt path rclone-test-rocazuc8cabi.bin: Auto set use_segments_container to true 2025/04/19 05:00:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rocazuc8cabi" 2025/04/19 05:00:01 DEBUG : Swift container crypt path rclone-test-rocazuc8cabi: Auto set use_segments_container to true 2025/04/19 05:00:11 DEBUG : potato2: md5 = 6f12038238dd29a9197a802a5bdf7358 OK 2025/04/19 05:00:16 DEBUG : empty space: md5 = 537d06a604bebd7a7c50fd0c424424ec OK 2025/04/19 05:00:22 DEBUG : potato3: md5 = 9db294278c9b188b237e6f0ed6a0499c OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya' -> Encrypted drive 'TestCryptSwift:rclone-test-rocazuc8cabi' 2025/04/19 05:00:28 DEBUG : empty space: md5 = 01ada1298bca1bc4f1d0d1c21635aa7b OK 2025/04/19 05:00:28 DEBUG : potato3: md5 = 064b3decdb22a7ea2311a71166486f6e OK 2025/04/19 05:00:29 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 05:00:29 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/19 05:00:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rocazuc8cabi': Waiting for checks to finish 2025/04/19 05:00:29 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:00:29 DEBUG : empty space: Unchanged skipping 2025/04/19 05:00:34 INFO : empty space: Deleted 2025/04/19 05:00:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rocazuc8cabi': Waiting for transfers to finish 2025/04/19 05:00:39 INFO : potato2: Copied (server-side copy) 2025/04/19 05:00:44 INFO : potato3: Copied (server-side copy) 2025/04/19 05:00:44 INFO : potato2: Deleted 2025/04/19 05:00:49 INFO : potato3: Deleted 2025/04/19 05:00:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-dariget7voyi" 2025/04/19 05:00:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-dariget7voyi.bin" 2025/04/19 05:00:50 DEBUG : Swift container crypt path rclone-test-dariget7voyi.bin: Auto set use_segments_container to true 2025/04/19 05:00:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-dariget7voyi" 2025/04/19 05:00:56 DEBUG : Swift container crypt path rclone-test-dariget7voyi: Auto set use_segments_container to true 2025/04/19 05:01:02 DEBUG : empty space: Need to transfer - File not found at Destination 2025/04/19 05:01:02 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 05:01:02 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/19 05:01:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dariget7voyi': Waiting for checks to finish 2025/04/19 05:01:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dariget7voyi': Waiting for transfers to finish 2025/04/19 05:01:12 INFO : potato2: Copied (server-side copy) 2025/04/19 05:01:12 INFO : potato3: Copied (server-side copy) 2025/04/19 05:01:12 INFO : empty space: Copied (server-side copy) 2025/04/19 05:01:12 INFO : potato2: Deleted 2025/04/19 05:01:12 INFO : empty space: Deleted 2025/04/19 05:01:13 INFO : potato3: Deleted 2025/04/19 05:01:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dariget7voyi': Purge remote 2025/04/19 05:01:13 DEBUG : Waiting for deletions to finish 2025/04/19 05:01:18 INFO : potato3.bin: Deleted 2025/04/19 05:01:19 INFO : empty space.bin: Deleted 2025/04/19 05:01:23 INFO : potato2.bin: Deleted 2025/04/19 05:01:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rocazuc8cabi': Purge remote 2025/04/19 05:01:23 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (89.32s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:01:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hanores6noqi" 2025/04/19 05:01:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hanores6noqi.bin" 2025/04/19 05:01:24 DEBUG : Swift container crypt path rclone-test-hanores6noqi.bin: Auto set use_segments_container to true 2025/04/19 05:01:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hanores6noqi" 2025/04/19 05:01:30 DEBUG : Swift container crypt path rclone-test-hanores6noqi: Auto set use_segments_container to true 2025/04/19 05:01:41 DEBUG : potato2: md5 = af89086a35fc4ddb0f1d229f0c62d9c6 OK 2025/04/19 05:01:46 DEBUG : empty space: md5 = e4ecb27e337e2ef23dcc62af19f078af OK 2025/04/19 05:01:51 DEBUG : potato3: md5 = 4e933e2952a1f813f4a32d495bcc4dc9 OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya' -> Encrypted drive 'TestCryptSwift:rclone-test-hanores6noqi' 2025/04/19 05:02:12 DEBUG : empty space: md5 = 9541f67afe1d588d15c46cb4afbce0f0 OK 2025/04/19 05:02:17 DEBUG : potato3: md5 = 8c9792161f54c04875f89f03c40a2973 OK 2025/04/19 05:02:22 DEBUG : empty space: Excluded (Size Filter) 2025/04/19 05:02:22 DEBUG : empty space: Excluded 2025/04/19 05:02:23 DEBUG : empty space: Excluded (Size Filter) 2025/04/19 05:02:23 DEBUG : empty space: Excluded 2025/04/19 05:02:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 05:02:23 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/19 05:02:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hanores6noqi': Waiting for checks to finish 2025/04/19 05:02:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hanores6noqi': Waiting for transfers to finish 2025/04/19 05:02:29 INFO : potato2: Copied (server-side copy) 2025/04/19 05:02:34 INFO : potato2: Deleted 2025/04/19 05:02:38 INFO : potato3: Copied (server-side copy) 2025/04/19 05:02:43 INFO : potato3: Deleted 2025/04/19 05:02:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-micirox9nama" 2025/04/19 05:02:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-micirox9nama.bin" 2025/04/19 05:02:44 DEBUG : Swift container crypt path rclone-test-micirox9nama.bin: Auto set use_segments_container to true 2025/04/19 05:02:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-micirox9nama" 2025/04/19 05:02:50 DEBUG : Swift container crypt path rclone-test-micirox9nama: Auto set use_segments_container to true 2025/04/19 05:02:55 DEBUG : empty space: Excluded (Size Filter) 2025/04/19 05:02:55 DEBUG : empty space: Excluded 2025/04/19 05:02:55 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 05:02:55 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/19 05:02:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-micirox9nama': Waiting for checks to finish 2025/04/19 05:02:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-micirox9nama': Waiting for transfers to finish 2025/04/19 05:03:06 INFO : potato3: Copied (server-side copy) 2025/04/19 05:03:11 INFO : potato2: Copied (server-side copy) 2025/04/19 05:03:11 INFO : potato3: Deleted 2025/04/19 05:03:11 INFO : potato2: Deleted 2025/04/19 05:03:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-micirox9nama': Purge remote 2025/04/19 05:03:12 DEBUG : Waiting for deletions to finish 2025/04/19 05:03:17 INFO : potato3.bin: Deleted 2025/04/19 05:03:17 INFO : potato2.bin: Deleted 2025/04/19 05:03:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hanores6noqi': Purge remote 2025/04/19 05:03:17 DEBUG : Waiting for deletions to finish 2025/04/19 05:03:27 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (133.84s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:03:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-rarofuz3funi" 2025/04/19 05:03:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rarofuz3funi.bin" 2025/04/19 05:03:38 DEBUG : Swift container crypt path rclone-test-rarofuz3funi.bin: Auto set use_segments_container to true 2025/04/19 05:03:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-rarofuz3funi" 2025/04/19 05:03:44 DEBUG : Swift container crypt path rclone-test-rarofuz3funi: Auto set use_segments_container to true 2025/04/19 05:03:55 DEBUG : potato2: md5 = ddc9fccaf722b3659003e2fbd1c50313 OK 2025/04/19 05:04:00 DEBUG : empty space: md5 = c0153b750f3bc5dd315174fbd7922101 OK 2025/04/19 05:04:05 DEBUG : potato3: md5 = ca3f1d4b209ad92159ccbcd8672f73cd OK 2025/04/19 05:04:05 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya' -> Encrypted drive 'TestCryptSwift:rclone-test-rarofuz3funi' 2025/04/19 05:04:21 DEBUG : empty space: md5 = 0b8202a2b891f0066c753d4a89b1f195 OK 2025/04/19 05:04:31 DEBUG : potato3: md5 = c2014b6fe90b9fc00ef9a47c4e51a3ac OK 2025/04/19 05:04:31 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 05:04:31 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/19 05:04:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rarofuz3funi': Waiting for checks to finish 2025/04/19 05:04:36 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:04:36 DEBUG : empty space: Unchanged skipping 2025/04/19 05:04:41 INFO : empty space: Deleted 2025/04/19 05:04:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rarofuz3funi': Waiting for transfers to finish 2025/04/19 05:04:42 INFO : potato3: Copied (server-side copy) 2025/04/19 05:04:47 INFO : potato3: Deleted 2025/04/19 05:04:47 INFO : potato2: Copied (server-side copy) 2025/04/19 05:04:52 INFO : potato2: Deleted 2025/04/19 05:04:57 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xovapuj5guxi" 2025/04/19 05:04:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xovapuj5guxi.bin" 2025/04/19 05:04:58 DEBUG : Swift container crypt path rclone-test-xovapuj5guxi.bin: Auto set use_segments_container to true 2025/04/19 05:05:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xovapuj5guxi" 2025/04/19 05:05:04 DEBUG : Swift container crypt path rclone-test-xovapuj5guxi: Auto set use_segments_container to true 2025/04/19 05:05:14 INFO : tomatoDir: Making directory 2025/04/19 05:05:14 DEBUG : empty space: Need to transfer - File not found at Destination 2025/04/19 05:05:14 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/19 05:05:14 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/19 05:05:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovapuj5guxi': Waiting for checks to finish 2025/04/19 05:05:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovapuj5guxi': Waiting for transfers to finish 2025/04/19 05:05:25 INFO : empty space: Copied (server-side copy) 2025/04/19 05:05:25 INFO : potato3: Copied (server-side copy) 2025/04/19 05:05:25 INFO : potato3: Deleted 2025/04/19 05:05:30 INFO : potato2: Copied (server-side copy) 2025/04/19 05:05:30 INFO : empty space: Deleted 2025/04/19 05:05:35 INFO : potato2: Deleted 2025/04/19 05:05:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xovapuj5guxi': Purge remote 2025/04/19 05:05:40 DEBUG : Waiting for deletions to finish 2025/04/19 05:05:41 INFO : empty space.bin: Deleted 2025/04/19 05:05:46 INFO : potato2.bin: Deleted 2025/04/19 05:05:46 INFO : potato3.bin: Deleted 2025/04/19 05:05:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-rarofuz3funi': Purge remote 2025/04/19 05:05:46 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (128.53s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:05:46 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/rclone-move-test" 2025/04/19 05:05:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-move-test.bin" 2025/04/19 05:05:47 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-move-test.bin: Auto set use_segments_container to true 2025/04/19 05:05:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-move-test" 2025/04/19 05:05:53 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-move-test: Auto set use_segments_container to true 2025/04/19 05:06:03 DEBUG : potato2: md5 = 585a1bcd07372ec97018ee668195cf62 OK --- PASS: TestServerSideMoveOverlap (27.80s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:06:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test" 2025/04/19 05:06:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-sync-test.bin" 2025/04/19 05:06:15 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-sync-test.bin: Auto set use_segments_container to true 2025/04/19 05:06:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-sync-test" 2025/04/19 05:06:20 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncOverlap (12.69s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:06:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test" 2025/04/19 05:06:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-sync-test.bin" 2025/04/19 05:06:27 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-sync-test.bin: Auto set use_segments_container to true 2025/04/19 05:06:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-sync-test" 2025/04/19 05:06:33 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-sync-test: Auto set use_segments_container to true 2025/04/19 05:06:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test-include/layer2" 2025/04/19 05:06:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-sync-test-include/layer2.bin" 2025/04/19 05:06:39 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/04/19 05:06:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-sync-test-include/layer2" 2025/04/19 05:06:44 DEBUG : Config file has changed externally - reloading 2025/04/19 05:06:45 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/04/19 05:06:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test-ignore-file" 2025/04/19 05:06:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-sync-test-ignore-file.bin" 2025/04/19 05:06:51 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/04/19 05:06:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/rclone-sync-test-ignore-file" 2025/04/19 05:06:57 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/04/19 05:07:03 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = 2a8b564332302427a99328665a701a67 OK 2025/04/19 05:07:08 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/19 05:07:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test': Waiting for checks to finish 2025/04/19 05:07:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test': Waiting for transfers to finish 2025/04/19 05:07:08 DEBUG : Waiting for deletions to finish 2025/04/19 05:07:08 INFO : There was nothing to transfer 2025/04/19 05:07:14 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/19 05:07:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 05:07:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 05:07:14 DEBUG : Waiting for deletions to finish 2025/04/19 05:07:14 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:07:19 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/19 05:07:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/04/19 05:07:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/04/19 05:07:19 DEBUG : Waiting for deletions to finish 2025/04/19 05:07:19 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:07:24 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/19 05:07:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 05:07:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 05:07:24 DEBUG : Waiting for deletions to finish 2025/04/19 05:07:24 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:07:24 DEBUG : : Excluded 2025/04/19 05:07:25 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/19 05:07:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/04/19 05:07:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/04/19 05:07:25 DEBUG : Waiting for deletions to finish 2025/04/19 05:07:25 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (61.61s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:07:28 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/dst" 2025/04/19 05:07:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst.bin" 2025/04/19 05:07:29 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst.bin: Auto set use_segments_container to true 2025/04/19 05:07:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst" 2025/04/19 05:07:35 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst: Auto set use_segments_container to true 2025/04/19 05:07:40 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/CompareDest" 2025/04/19 05:07:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/CompareDest.bin" 2025/04/19 05:07:41 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/CompareDest.bin: Auto set use_segments_container to true 2025/04/19 05:07:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/CompareDest" 2025/04/19 05:07:47 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/CompareDest: Auto set use_segments_container to true 2025/04/19 05:07:57 DEBUG : one: Need to transfer - File not found at Destination 2025/04/19 05:07:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:07:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:07:58 DEBUG : one: md5 = 933ad7c337362d9e74e0fc20d9641d52 OK 2025/04/19 05:07:58 INFO : one: Copied (new) 2025/04/19 05:07:58 DEBUG : Waiting for deletions to finish 2025/04/19 05:07:58 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/19 05:07:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:08:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:08:03 DEBUG : one: md5 = 80d8203faec67ed3cbae227d064bb543 OK 2025/04/19 05:08:03 INFO : one: Copied (replaced existing) 2025/04/19 05:08:03 DEBUG : Waiting for deletions to finish 2025/04/19 05:08:04 DEBUG : dst/one: md5 = 37bf75533f42bdb8f80ffe6c13d99fe5 OK 2025/04/19 05:08:04 DEBUG : CompareDest/one: md5 = 9b315c3f536744092e7b9950a4c65e74 OK 2025/04/19 05:08:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:08:04 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/19 05:08:04 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:08:04 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/19 05:08:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:08:04 DEBUG : Waiting for deletions to finish 2025/04/19 05:08:04 INFO : There was nothing to transfer 2025/04/19 05:08:10 DEBUG : CompareDest/two: md5 = 18634bfc2afe6b11f1fa81d515a55fac OK 2025/04/19 05:08:10 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/19 05:08:10 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:08:10 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/19 05:08:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:08:15 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/19 05:08:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:08:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:08:15 DEBUG : Waiting for deletions to finish 2025/04/19 05:08:15 INFO : There was nothing to transfer 2025/04/19 05:08:21 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/19 05:08:21 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:08:21 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/19 05:08:26 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:08:26 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/19 05:08:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:08:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:08:26 DEBUG : Waiting for deletions to finish 2025/04/19 05:08:26 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2025/04/19 05:08:26 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/19 05:08:26 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:08:26 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/19 05:08:26 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/04/19 05:08:26 DEBUG : two: Need to transfer - File not found at Destination 2025/04/19 05:08:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:08:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:08:32 DEBUG : two: md5 = 894d4367d44f45770eaee97a6503c393 OK 2025/04/19 05:08:32 INFO : two: Copied (new) 2025/04/19 05:08:32 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (74.45s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:08:44 DEBUG : pre-dest1/1: md5 = d52ff7a5e4d7f60ecd365bb8f91e1cc2 OK 2025/04/19 05:08:49 DEBUG : pre-dest2/2: md5 = d86b3752bc9d91e91902f442326460e7 OK 2025/04/19 05:08:49 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/dest" 2025/04/19 05:08:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dest.bin" 2025/04/19 05:08:50 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dest.bin: Auto set use_segments_container to true 2025/04/19 05:08:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dest" 2025/04/19 05:08:56 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dest: Auto set use_segments_container to true 2025/04/19 05:09:01 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/pre-dest1" 2025/04/19 05:09:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/pre-dest1.bin" 2025/04/19 05:09:02 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/pre-dest1.bin: Auto set use_segments_container to true 2025/04/19 05:09:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/pre-dest1" 2025/04/19 05:09:08 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/pre-dest1: Auto set use_segments_container to true 2025/04/19 05:09:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/pre-dest2" 2025/04/19 05:09:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/pre-dest2.bin" 2025/04/19 05:09:14 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/pre-dest2.bin: Auto set use_segments_container to true 2025/04/19 05:09:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/pre-dest2" 2025/04/19 05:09:19 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/pre-dest2: Auto set use_segments_container to true 2025/04/19 05:09:25 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:09:25 DEBUG : 1: Destination found in --compare-dest, skipping 2025/04/19 05:09:30 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:09:30 DEBUG : 2: Destination found in --compare-dest, skipping 2025/04/19 05:09:40 DEBUG : 3: Need to transfer - File not found at Destination 2025/04/19 05:09:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dest': Waiting for checks to finish 2025/04/19 05:09:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dest': Waiting for transfers to finish 2025/04/19 05:09:46 DEBUG : 3: md5 = 559c33eb572d40fa3404f8c9ee3a0e03 OK 2025/04/19 05:09:46 INFO : 3: Copied (new) 2025/04/19 05:09:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (79.13s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:10:02 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/dst" 2025/04/19 05:10:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst.bin" 2025/04/19 05:10:02 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst.bin: Auto set use_segments_container to true 2025/04/19 05:10:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst" 2025/04/19 05:10:08 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst: Auto set use_segments_container to true 2025/04/19 05:10:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/CopyDest" 2025/04/19 05:10:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/CopyDest.bin" 2025/04/19 05:10:14 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/CopyDest.bin: Auto set use_segments_container to true 2025/04/19 05:10:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/CopyDest" 2025/04/19 05:10:20 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/CopyDest: Auto set use_segments_container to true 2025/04/19 05:10:31 DEBUG : one: Need to transfer - File not found at Destination 2025/04/19 05:10:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:10:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:10:31 DEBUG : one: md5 = a44cee8ebd364834d71922152f5bcc2e OK 2025/04/19 05:10:31 INFO : one: Copied (new) 2025/04/19 05:10:31 DEBUG : Waiting for deletions to finish 2025/04/19 05:10:31 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/19 05:10:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:10:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:10:37 DEBUG : one: md5 = 8a1133cb613cfe3500b22286bd20658d OK 2025/04/19 05:10:37 INFO : one: Copied (replaced existing) 2025/04/19 05:10:37 DEBUG : Waiting for deletions to finish 2025/04/19 05:10:37 DEBUG : dst/one: md5 = 22ddf7d8acf32bb8916dc1666e01ee40 OK 2025/04/19 05:10:37 DEBUG : CopyDest/one: md5 = 2003567026958611cc739ba15ed6c1b3 OK 2025/04/19 05:10:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/BackupDir" 2025/04/19 05:10:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/BackupDir.bin" 2025/04/19 05:10:38 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/BackupDir.bin: Auto set use_segments_container to true 2025/04/19 05:10:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/BackupDir" 2025/04/19 05:10:44 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/BackupDir: Auto set use_segments_container to true 2025/04/19 05:10:55 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/19 05:10:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:10:55 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:10:55 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/19 05:11:11 INFO : one: Copied (server-side copy) 2025/04/19 05:11:11 INFO : one: Deleted 2025/04/19 05:11:16 INFO : one: Copied (server-side copy) 2025/04/19 05:11:16 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/04/19 05:11:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:11:16 DEBUG : Waiting for deletions to finish 2025/04/19 05:11:16 DEBUG : CopyDest/two: md5 = 1e1a2b9af29390fe5a3cc0f7574ec62a OK 2025/04/19 05:11:17 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:11:17 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:11:17 DEBUG : one: Unchanged skipping 2025/04/19 05:11:32 INFO : two: Copied (server-side copy) 2025/04/19 05:11:32 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/04/19 05:11:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:11:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:11:32 DEBUG : Waiting for deletions to finish 2025/04/19 05:11:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:11:38 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:11:38 DEBUG : one: Unchanged skipping 2025/04/19 05:11:43 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:11:43 DEBUG : two: Unchanged skipping 2025/04/19 05:11:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:11:43 DEBUG : Waiting for deletions to finish 2025/04/19 05:11:43 INFO : There was nothing to transfer 2025/04/19 05:11:53 DEBUG : CopyDest/three: md5 = 5c012518306c649162be0dc53c9b1d15 OK 2025/04/19 05:12:04 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:12:04 DEBUG : one: Unchanged skipping 2025/04/19 05:12:09 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/04/19 05:12:09 DEBUG : three: Destination not found in --copy-dest 2025/04/19 05:12:09 DEBUG : three: Need to transfer - File not found at Destination 2025/04/19 05:12:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:12:14 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:12:14 DEBUG : two: Unchanged skipping 2025/04/19 05:12:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:12:14 DEBUG : three: md5 = 795a42982f1757064c58f6397ed2c9dc OK 2025/04/19 05:12:14 INFO : three: Copied (new) 2025/04/19 05:12:14 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (174.02s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:12:56 DEBUG : dst/one: md5 = c37eb101b3948b4bd07e251854f6f2fc OK 2025/04/19 05:13:01 DEBUG : dst/two: md5 = 73d4e423035759d4c9c41b747c1785bb OK 2025/04/19 05:13:01 DEBUG : dst/three.txt: md5 = 544b01f804ee3330a8c47496dae5566d OK 2025/04/19 05:13:02 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/dst" 2025/04/19 05:13:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst.bin" 2025/04/19 05:13:03 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst.bin: Auto set use_segments_container to true 2025/04/19 05:13:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst" 2025/04/19 05:13:08 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst: Auto set use_segments_container to true 2025/04/19 05:13:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/backup" 2025/04/19 05:13:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/backup.bin" 2025/04/19 05:13:14 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/backup.bin: Auto set use_segments_container to true 2025/04/19 05:13:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/backup" 2025/04/19 05:13:20 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/backup: Auto set use_segments_container to true 2025/04/19 05:13:25 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/19 05:13:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:13:30 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:13:30 DEBUG : two: Unchanged skipping 2025/04/19 05:13:48 INFO : one: Copied (server-side copy) 2025/04/19 05:13:48 INFO : one: Deleted 2025/04/19 05:13:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:13:48 DEBUG : one: md5 = e12e3cdd40e854b84a859512c501b0bb OK 2025/04/19 05:13:48 INFO : one: Copied (new) 2025/04/19 05:13:48 DEBUG : Waiting for deletions to finish 2025/04/19 05:13:59 INFO : three.txt: Copied (server-side copy) 2025/04/19 05:13:59 INFO : three.txt: Deleted 2025/04/19 05:13:59 INFO : three.txt: Moved into backup dir 2025/04/19 05:14:05 DEBUG : dst/three.txt: md5 = d24be509b287176cac9e858b187d9454 OK 2025/04/19 05:14:10 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/19 05:14:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:14:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:14:10 DEBUG : two: Unchanged skipping 2025/04/19 05:14:21 INFO : one: Copied (server-side copy) 2025/04/19 05:14:21 INFO : one: Deleted 2025/04/19 05:14:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:14:21 DEBUG : one: md5 = a8e1e63c745d8c7da8155f48ce3a15d3 OK 2025/04/19 05:14:21 INFO : one: Copied (new) 2025/04/19 05:14:21 DEBUG : Waiting for deletions to finish 2025/04/19 05:14:26 INFO : three.txt: Copied (server-side copy) 2025/04/19 05:14:27 INFO : three.txt: Deleted 2025/04/19 05:14:27 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (111.78s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:14:48 DEBUG : dst/one: md5 = 6f910f7003928e09ddcaa4bf877882ec OK 2025/04/19 05:14:53 DEBUG : dst/two: md5 = 46349f39d84a9f0e5fe042e5873aaee2 OK 2025/04/19 05:14:53 DEBUG : dst/three.txt: md5 = f9109fef025af0080267d738172afdd3 OK 2025/04/19 05:14:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/dst" 2025/04/19 05:14:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst.bin" 2025/04/19 05:14:54 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst.bin: Auto set use_segments_container to true 2025/04/19 05:14:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst" 2025/04/19 05:15:00 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst: Auto set use_segments_container to true 2025/04/19 05:15:05 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/backup" 2025/04/19 05:15:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/backup.bin" 2025/04/19 05:15:05 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/backup.bin: Auto set use_segments_container to true 2025/04/19 05:15:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/backup" 2025/04/19 05:15:11 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/backup: Auto set use_segments_container to true 2025/04/19 05:15:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/19 05:15:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:15:17 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:15:17 DEBUG : two: Unchanged skipping 2025/04/19 05:15:32 INFO : one: Copied (server-side copy) to: one.bak 2025/04/19 05:15:32 INFO : one: Deleted 2025/04/19 05:15:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:15:33 DEBUG : one: md5 = 5ceb0c6b23ed20f0df4250039b0d7d82 OK 2025/04/19 05:15:33 INFO : one: Copied (new) 2025/04/19 05:15:33 DEBUG : Waiting for deletions to finish 2025/04/19 05:15:43 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/19 05:15:43 INFO : three.txt: Deleted 2025/04/19 05:15:43 INFO : three.txt: Moved into backup dir 2025/04/19 05:15:44 DEBUG : dst/three.txt: md5 = 24b68d76412f76624bc5ff5b22cf1859 OK 2025/04/19 05:15:44 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/19 05:15:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:15:49 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:15:49 DEBUG : two: Unchanged skipping 2025/04/19 05:15:55 INFO : one: Copied (server-side copy) to: one.bak 2025/04/19 05:15:55 INFO : one: Deleted 2025/04/19 05:15:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:15:55 DEBUG : one: md5 = 4c353e8fdd1770d1f57e2c023cee52cb OK 2025/04/19 05:15:55 INFO : one: Copied (new) 2025/04/19 05:15:55 DEBUG : Waiting for deletions to finish 2025/04/19 05:16:00 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/19 05:16:00 INFO : three.txt: Deleted 2025/04/19 05:16:00 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (88.61s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:16:16 DEBUG : dst/one: md5 = 5ab128b89b16720241997bb920eb1283 OK 2025/04/19 05:16:22 DEBUG : dst/two: md5 = 88453a3cad67ab08a95a13a51ab9e3a3 OK 2025/04/19 05:16:22 DEBUG : dst/three.txt: md5 = ea88760f65b1be53e8a7ca348f36c6f9 OK 2025/04/19 05:16:22 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/dst" 2025/04/19 05:16:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst.bin" 2025/04/19 05:16:23 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst.bin: Auto set use_segments_container to true 2025/04/19 05:16:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst" 2025/04/19 05:16:28 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst: Auto set use_segments_container to true 2025/04/19 05:16:33 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/backup" 2025/04/19 05:16:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/backup.bin" 2025/04/19 05:16:34 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/backup.bin: Auto set use_segments_container to true 2025/04/19 05:16:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/backup" 2025/04/19 05:16:40 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/backup: Auto set use_segments_container to true 2025/04/19 05:16:45 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/19 05:16:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:16:45 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:16:45 DEBUG : two: Unchanged skipping 2025/04/19 05:17:06 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/19 05:17:06 INFO : one: Deleted 2025/04/19 05:17:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:17:06 DEBUG : one: md5 = 34ff1a6a896529516ddfbb9bdd873c82 OK 2025/04/19 05:17:06 INFO : one: Copied (new) 2025/04/19 05:17:06 DEBUG : Waiting for deletions to finish 2025/04/19 05:17:16 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/19 05:17:16 INFO : three.txt: Deleted 2025/04/19 05:17:16 INFO : three.txt: Moved into backup dir 2025/04/19 05:17:17 DEBUG : dst/three.txt: md5 = 3cd4030f1b995c637273c2b5b3663287 OK 2025/04/19 05:17:23 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/19 05:17:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:17:28 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:17:28 DEBUG : two: Unchanged skipping 2025/04/19 05:17:33 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/19 05:17:33 INFO : one: Deleted 2025/04/19 05:17:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:17:33 DEBUG : one: md5 = b74dd347f894c57b7d9e6801ea340615 OK 2025/04/19 05:17:33 INFO : one: Copied (new) 2025/04/19 05:17:33 DEBUG : Waiting for deletions to finish 2025/04/19 05:17:39 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/19 05:17:39 INFO : three.txt: Deleted 2025/04/19 05:17:39 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (98.41s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:17:55 DEBUG : dst/one: md5 = 540f22cc29c84c4daf97b918b0d945a8 OK 2025/04/19 05:18:00 DEBUG : dst/two: md5 = fd0f14034f026406fba1ceef90a77a56 OK 2025/04/19 05:18:00 DEBUG : dst/three.txt: md5 = b1b070e7fd2d8292b1586f1b2bc7baee OK 2025/04/19 05:18:05 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/dst" 2025/04/19 05:18:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst.bin" 2025/04/19 05:18:06 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst.bin: Auto set use_segments_container to true 2025/04/19 05:18:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst" 2025/04/19 05:18:12 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst: Auto set use_segments_container to true 2025/04/19 05:18:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/19 05:18:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:18:17 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:18:17 DEBUG : two: Unchanged skipping 2025/04/19 05:18:37 INFO : one: Copied (server-side copy) to: one.bak 2025/04/19 05:18:38 INFO : one: Deleted 2025/04/19 05:18:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:18:38 DEBUG : one: md5 = 8d4e6e7a090a993ace8f1c3c2c09444a OK 2025/04/19 05:18:38 INFO : one: Copied (new) 2025/04/19 05:18:38 DEBUG : Waiting for deletions to finish 2025/04/19 05:18:53 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/19 05:18:53 INFO : three.txt: Deleted 2025/04/19 05:18:53 INFO : three.txt: Moved into backup dir 2025/04/19 05:18:54 DEBUG : dst/three.txt: md5 = 42f6ce9c178127bd46398a8d1f444c76 OK 2025/04/19 05:19:00 DEBUG : one.bak: Excluded (Path Filter) 2025/04/19 05:19:00 DEBUG : one.bak: Excluded 2025/04/19 05:19:00 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/04/19 05:19:00 DEBUG : three.txt.bak: Excluded 2025/04/19 05:19:00 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/19 05:19:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for checks to finish 2025/04/19 05:19:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:19:00 DEBUG : two: Unchanged skipping 2025/04/19 05:19:10 INFO : one: Copied (server-side copy) to: one.bak 2025/04/19 05:19:10 INFO : one: Deleted 2025/04/19 05:19:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya/dst': Waiting for transfers to finish 2025/04/19 05:19:10 DEBUG : one: md5 = ef3f8dbff6379605a983a5437617c9d4 OK 2025/04/19 05:19:10 INFO : one: Copied (new) 2025/04/19 05:19:10 DEBUG : Waiting for deletions to finish 2025/04/19 05:19:21 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/19 05:19:21 INFO : three.txt: Deleted 2025/04/19 05:19:21 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (112.15s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:19:47 DEBUG : dst/one: md5 = 648335b41366727eb51e783151349832 OK 2025/04/19 05:19:52 DEBUG : dst/two: md5 = d4c89c195851d302eef5236a29b7bc02 OK 2025/04/19 05:19:52 DEBUG : dst/three.txt: md5 = bf8744024cc8a7f051f0211903d7c282 OK 2025/04/19 05:19:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/dst" 2025/04/19 05:19:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst.bin" 2025/04/19 05:19:53 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst.bin: Auto set use_segments_container to true 2025/04/19 05:19:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst" 2025/04/19 05:19:59 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst: Auto set use_segments_container to true 2025/04/19 05:20:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/19 05:20:24 INFO : one: Copied (server-side copy) to: one.bak 2025/04/19 05:20:24 INFO : one: Deleted 2025/04/19 05:20:25 DEBUG : one: md5 = 62c1da63e28f456345c0fa9bb314fb1f OK 2025/04/19 05:20:25 INFO : one: Copied (new) 2025/04/19 05:20:25 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:20:25 DEBUG : two: Unchanged skipping 2025/04/19 05:20:25 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/19 05:20:40 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/19 05:20:40 INFO : three.txt: Deleted 2025/04/19 05:20:40 DEBUG : three.txt: md5 = 7b680e1a27302f473763c5f285f12199 OK 2025/04/19 05:20:40 INFO : three.txt: Copied (new) 2025/04/19 05:20:56 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/19 05:21:07 INFO : one: Copied (server-side copy) to: one.bak 2025/04/19 05:21:07 INFO : one: Deleted 2025/04/19 05:21:07 DEBUG : one: md5 = ac6ab68a20cd55774343ecb47f4c081d OK 2025/04/19 05:21:07 INFO : one: Copied (new) 2025/04/19 05:21:12 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:21:12 DEBUG : two: Unchanged skipping 2025/04/19 05:21:12 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/04/19 05:21:27 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/19 05:21:27 INFO : three.txt: Deleted 2025/04/19 05:21:28 DEBUG : three.txt: md5 = fb57575ef83b07f105e6319949a8366a OK 2025/04/19 05:21:28 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (137.00s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:22:04 DEBUG : dst/one: md5 = bb6df0df9a474696e0beb1fe105df365 OK 2025/04/19 05:22:09 DEBUG : dst/two: md5 = ba988f3aa3d4f8115eb733c79584b376 OK 2025/04/19 05:22:09 DEBUG : dst/three.txt: md5 = 66bfe1cc284435fd1aa04a7b25d304e5 OK 2025/04/19 05:22:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zufotuq0ziya/dst" 2025/04/19 05:22:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst.bin" 2025/04/19 05:22:10 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst.bin: Auto set use_segments_container to true 2025/04/19 05:22:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zufotuq0ziya/dst" 2025/04/19 05:22:16 DEBUG : Swift container crypt path rclone-test-zufotuq0ziya/dst: Auto set use_segments_container to true 2025/04/19 05:22:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/19 05:22:32 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/19 05:22:32 INFO : one: Deleted 2025/04/19 05:22:32 DEBUG : one: md5 = cdb8bc18a7a90094b1a9c02da4e4b98f OK 2025/04/19 05:22:32 INFO : one: Copied (new) 2025/04/19 05:22:32 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:22:32 DEBUG : two: Unchanged skipping 2025/04/19 05:22:32 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/19 05:22:53 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/19 05:22:53 INFO : three.txt: Deleted 2025/04/19 05:22:53 DEBUG : three.txt: md5 = 29f8013094cca00d4a930f51e9113e1e OK 2025/04/19 05:22:53 INFO : three.txt: Copied (new) 2025/04/19 05:23:04 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/19 05:23:09 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/19 05:23:09 INFO : one: Deleted 2025/04/19 05:23:10 DEBUG : one: md5 = c0c18f800ed4a9b4f2d786ab7f10a76c OK 2025/04/19 05:23:10 INFO : one: Copied (new) 2025/04/19 05:23:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:23:15 DEBUG : two: Unchanged skipping 2025/04/19 05:23:15 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/04/19 05:23:25 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/19 05:23:25 INFO : three.txt: Deleted 2025/04/19 05:23:25 DEBUG : three.txt: md5 = ceaca122b33745680085fb0181ba6687 OK 2025/04/19 05:23:25 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (107.66s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:23:57 DEBUG : Testêé: md5 = 48b531cf371e1266b60f3a3fb04a6488 OK 2025/04/19 05:23:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 05:23:57 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/04/19 05:23:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 05:24:02 DEBUG : Testêé: md5 = 2f939cb29aa24002211123c662b47fbc OK 2025/04/19 05:24:02 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/04/19 05:24:02 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (21.30s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:24:13 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/19 05:24:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 05:24:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 05:24:14 DEBUG : existing: md5 = d166d4a5a2297dba25a0d3de6ec2d1f2 OK 2025/04/19 05:24:14 INFO : existing: Copied (new) 2025/04/19 05:24:14 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:24:14 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/04/19 05:24:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 05:24:14 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/04/19 05:24:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 05:24:14 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': not deleting files as there were IO errors 2025/04/19 05:24:14 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncImmutable (2.26s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:24:16 DEBUG : EXISTING: md5 = 4abf7c533170d0701ad22123c0ff1f12 OK 2025/04/19 05:24:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 05:24:16 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:24:16 DEBUG : existing: Unchanged skipping 2025/04/19 05:24:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 05:24:16 DEBUG : Waiting for deletions to finish 2025/04/19 05:24:16 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.44s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.31s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.29s) --- SKIP: TestMaxTransfer/Hard (0.10s) --- SKIP: TestMaxTransfer/Soft (0.09s) --- SKIP: TestMaxTransfer/Cautious (0.10s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:24:22 DEBUG : both0: md5 = 65ed3421762d464b73eb73cbc1da3f65 OK 2025/04/19 05:24:23 DEBUG : only0: md5 = ca20cdbaefb1aa460c7306a4e1de8615 OK 2025/04/19 05:24:28 DEBUG : both1: md5 = d211c5fcc6023aa4130849c7b5acf4a5 OK 2025/04/19 05:24:33 DEBUG : only1: md5 = 595db35f19b732c3e6d03b49530d7637 OK 2025/04/19 05:24:34 DEBUG : both2: md5 = 8626938b101e6b87306bc0ca600928ab OK 2025/04/19 05:24:40 DEBUG : only2: md5 = a69411e99b8c28930ef908f426c2b373 OK 2025/04/19 05:24:40 DEBUG : both3: md5 = f61e8fe607c564c75134e90ede7c4864 OK 2025/04/19 05:24:40 DEBUG : only3: md5 = dad6f40239565809705edec391d895e4 OK 2025/04/19 05:24:41 DEBUG : both4: md5 = 02fce5f817fe1923a9eb8624ef34f3d7 OK 2025/04/19 05:24:46 DEBUG : only4: md5 = 2228ce7af6f239d5420a94a55a6595a7 OK 2025/04/19 05:24:52 DEBUG : both5: md5 = 1b48141c2edc9da9670bbb8bdd0d2595 OK 2025/04/19 05:24:52 DEBUG : only5: md5 = adcdb39d61567d7937e0bfee19494165 OK 2025/04/19 05:24:53 DEBUG : both6: md5 = 0fa6b24b4ca8d7e7a7b558c6c10c580c OK 2025/04/19 05:24:58 DEBUG : only6: md5 = d531bd39847e8c32f7d39392fb1b67ba OK 2025/04/19 05:25:03 DEBUG : both7: md5 = c4d4e5979e04d74f196352e29339c3be OK 2025/04/19 05:25:09 DEBUG : only7: md5 = 4af864106a612e6bd2af19eff86a7365 OK 2025/04/19 05:25:14 DEBUG : both8: md5 = 2c7ae89f390d8a1d7c34a9f1815a331b OK 2025/04/19 05:25:19 DEBUG : only8: md5 = 2d166a1e3acbd0d0eee1dc8eddf9abf4 OK 2025/04/19 05:25:20 DEBUG : both9: md5 = 7f0a2f5c3b590cd7458ad0fd12de326e OK 2025/04/19 05:25:20 DEBUG : only9: md5 = abe833b721b50c29d9fee98542253bc8 OK 2025/04/19 05:25:26 DEBUG : both10: md5 = 0cbd76a27d25a8c27cf828f87424b7c2 OK 2025/04/19 05:25:26 DEBUG : only10: md5 = 1516c5c60962d47cd68bbaffb42e9b87 OK 2025/04/19 05:25:27 DEBUG : both11: md5 = 1a88acbbac2e304bccf4e418cc3fd7d0 OK 2025/04/19 05:25:33 DEBUG : only11: md5 = e5d525192318e40f9fcfeb6121f85dc5 OK 2025/04/19 05:25:33 DEBUG : both12: md5 = 2bb191d94ae1c4c058559fd237f1dc3a OK 2025/04/19 05:25:38 DEBUG : only12: md5 = 6b7f98766a2dc38d2a7e513161edc1aa OK 2025/04/19 05:25:44 DEBUG : both13: md5 = f059bdf9881263b83b5b6aeb59114c04 OK 2025/04/19 05:25:49 DEBUG : only13: md5 = ae9bbb1c52d74732cf8ba28792dc882e OK 2025/04/19 05:25:54 DEBUG : both14: md5 = b562ae5c4f9c458b265730dea88034a7 OK 2025/04/19 05:25:55 DEBUG : only14: md5 = 5bb23cd9e77cc9c0f4f2c80dc11eb880 OK 2025/04/19 05:26:00 DEBUG : both15: md5 = e511f40e4ed50669b8292ab67887fcf0 OK 2025/04/19 05:26:05 DEBUG : only15: md5 = 4ad390de06480db116d17d92f339663c OK 2025/04/19 05:26:06 DEBUG : both16: md5 = 55f1c737a9e0d920960d916f9f3ef88d OK 2025/04/19 05:26:11 DEBUG : only16: md5 = e347c79285fc29888989ad8e8fba0101 OK 2025/04/19 05:26:11 DEBUG : both17: md5 = 2442f29cda033c3e4a1921320ac15dc6 OK 2025/04/19 05:26:12 DEBUG : only17: md5 = 1ab61466eb790d3ed772954500d41770 OK 2025/04/19 05:26:17 DEBUG : both18: md5 = 9b92a8afb9ddf7f909ef23fe4ce83c52 OK 2025/04/19 05:26:18 DEBUG : only18: md5 = 2cdc061d076b24724f674d506cb03226 OK 2025/04/19 05:26:18 DEBUG : both19: md5 = c5026971f7b1defa6a92aec18a14a9b5 OK 2025/04/19 05:26:18 DEBUG : only19: md5 = bd9c1535f374c9f519e97c9299a8a034 OK 2025/04/19 05:27:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 05:27:00 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:00 DEBUG : both10: Unchanged skipping 2025/04/19 05:27:00 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:00 DEBUG : both0: Unchanged skipping 2025/04/19 05:27:00 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:00 DEBUG : both1: Unchanged skipping 2025/04/19 05:27:00 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:00 DEBUG : both11: Unchanged skipping 2025/04/19 05:27:00 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:00 DEBUG : both12: Unchanged skipping 2025/04/19 05:27:00 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:00 DEBUG : both15: Unchanged skipping 2025/04/19 05:27:00 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:00 DEBUG : both16: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both17: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both18: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both19: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both2: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both3: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both4: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both6: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both7: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both8: Unchanged skipping 2025/04/19 05:27:01 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:01 DEBUG : both9: Unchanged skipping 2025/04/19 05:27:05 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:05 DEBUG : both13: Unchanged skipping 2025/04/19 05:27:05 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:05 DEBUG : both14: Unchanged skipping 2025/04/19 05:27:06 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:27:06 DEBUG : both5: Unchanged skipping 2025/04/19 05:27:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 05:27:06 DEBUG : Waiting for deletions to finish 2025/04/19 05:27:06 INFO : only5: Deleted 2025/04/19 05:27:06 INFO : only0: Deleted 2025/04/19 05:27:06 INFO : only19: Deleted 2025/04/19 05:27:06 INFO : only10: Deleted 2025/04/19 05:27:06 INFO : only3: Deleted 2025/04/19 05:27:11 INFO : only4: Deleted 2025/04/19 05:27:11 INFO : only14: Deleted 2025/04/19 05:27:11 INFO : only11: Deleted 2025/04/19 05:27:11 INFO : only6: Deleted 2025/04/19 05:27:12 INFO : only17: Deleted 2025/04/19 05:27:12 INFO : only12: Deleted 2025/04/19 05:27:12 INFO : only18: Deleted 2025/04/19 05:27:12 INFO : only9: Deleted 2025/04/19 05:27:16 INFO : only16: Deleted 2025/04/19 05:27:17 INFO : only7: Deleted 2025/04/19 05:27:17 INFO : only1: Deleted 2025/04/19 05:27:22 INFO : only2: Deleted 2025/04/19 05:27:22 INFO : only8: Deleted 2025/04/19 05:27:26 INFO : only13: Deleted 2025/04/19 05:27:27 INFO : only15: Deleted 2025/04/19 05:27:27 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (270.44s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:28:53 DEBUG : both0: md5 = b5adc7cc1039b5e5367c3cf801c42637 OK 2025/04/19 05:28:53 DEBUG : only0: md5 = 86235405f6a7bb6c6029b8f35cfde996 OK 2025/04/19 05:28:58 DEBUG : both1: md5 = da326a05bda1daf5fc7ad431aeeeec46 OK 2025/04/19 05:29:03 DEBUG : only1: md5 = ec80e197749de662db2455f2f153cd9b OK 2025/04/19 05:29:03 DEBUG : both2: md5 = 59ce3c0f701b5a7d139a3eaa1a9fa274 OK 2025/04/19 05:29:08 DEBUG : only2: md5 = 4be7e04c5d30f2f07899ab9a1179969e OK 2025/04/19 05:29:09 DEBUG : both3: md5 = cd63fb75b365649f33c9a7b4ff8a4b16 OK 2025/04/19 05:29:09 DEBUG : only3: md5 = fa2eb7a09ffa55afd2524c409aca4c95 OK 2025/04/19 05:29:09 DEBUG : both4: md5 = 92f19f70205a1c682cedec1fdea2d854 OK 2025/04/19 05:29:14 DEBUG : only4: md5 = bea3fe871fc2dd3beb96a9eb45e3ed41 OK 2025/04/19 05:29:19 DEBUG : both5: md5 = aeae7e104d13ee7d94b5408e1d52b65e OK 2025/04/19 05:29:19 DEBUG : only5: md5 = 0e66409fb0146e2c5ff9c6601b467fd9 OK 2025/04/19 05:29:20 DEBUG : both6: md5 = f64149a14711b39a028f7a23aa7fe7a4 OK 2025/04/19 05:29:25 DEBUG : only6: md5 = e7063fede324ab9d0b024035bbc779db OK 2025/04/19 05:29:30 DEBUG : both7: md5 = 7de774e78c285ce7c0c51d7261f65724 OK 2025/04/19 05:29:35 DEBUG : only7: md5 = bd16d5d7a73af0a0e7c7b3be8d05cc94 OK 2025/04/19 05:29:40 DEBUG : both8: md5 = ef87e4a0578556f74546e616eb9442d2 OK 2025/04/19 05:29:45 DEBUG : only8: md5 = bdfceb3699a003ae1cc416dc9c76ab56 OK 2025/04/19 05:29:46 DEBUG : both9: md5 = ae390b4991aca6982e0d17e3641332c3 OK 2025/04/19 05:29:46 DEBUG : only9: md5 = 4f316e6b295835d624e867e0a4bf0104 OK 2025/04/19 05:29:51 DEBUG : both10: md5 = 09188a07f2aa843ed2df6aab58d87ce1 OK 2025/04/19 05:29:51 DEBUG : only10: md5 = 587d263c834fd81728bf9283e128b621 OK 2025/04/19 05:29:51 DEBUG : both11: md5 = cdec5939bc27edc08a45028fff91c300 OK 2025/04/19 05:29:57 DEBUG : only11: md5 = 8ae1e7b53f32579aa88f6950de0503b7 OK 2025/04/19 05:29:57 DEBUG : both12: md5 = 051df2f488c36937877f4255dabab33b OK 2025/04/19 05:30:02 DEBUG : only12: md5 = f2bf2d552f8e238131b2a6696ff5434d OK 2025/04/19 05:30:07 DEBUG : both13: md5 = ea03b5d572797d7388523bc8bc1368e7 OK 2025/04/19 05:30:12 DEBUG : only13: md5 = 18dfa0383392b78ffaaeb64791e457d2 OK 2025/04/19 05:30:17 DEBUG : both14: md5 = 6d534a3bf04b5389f49d46aacf3df633 OK 2025/04/19 05:30:18 DEBUG : only14: md5 = cad69cc0205d41f8a13501a0e7c874df OK 2025/04/19 05:30:23 DEBUG : both15: md5 = 099c9342154597fa6262c9d290f018f2 OK 2025/04/19 05:30:28 DEBUG : only15: md5 = a9e0448fe7302b91d770a39b4f14ac46 OK 2025/04/19 05:30:28 DEBUG : both16: md5 = 6c799a4b91d39855961b025a27688cce OK 2025/04/19 05:30:33 DEBUG : only16: md5 = af376e0bd9227b2daf515a73ba8dcbdd OK 2025/04/19 05:30:33 DEBUG : both17: md5 = befe9329343b3d85abe4f49d77a0e704 OK 2025/04/19 05:30:33 DEBUG : only17: md5 = ed38102726b6091345d7332c020d6b41 OK 2025/04/19 05:30:39 DEBUG : both18: md5 = fd40f4837f160538567fd253c88a42d8 OK 2025/04/19 05:30:39 DEBUG : only18: md5 = ee9a528dfebdbb51bc36cd50eb908cd2 OK 2025/04/19 05:30:39 DEBUG : both19: md5 = a5c1fef326b18c5a320836ebe66d699c OK 2025/04/19 05:30:39 DEBUG : only19: md5 = 4054773f255d891e89f38c4b64b60f38 OK 2025/04/19 05:31:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for checks to finish 2025/04/19 05:31:26 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:26 DEBUG : both0: Unchanged skipping 2025/04/19 05:31:26 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:26 DEBUG : both11: Unchanged skipping 2025/04/19 05:31:26 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:26 DEBUG : both10: Unchanged skipping 2025/04/19 05:31:26 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:26 DEBUG : both12: Unchanged skipping 2025/04/19 05:31:26 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:26 DEBUG : both13: Unchanged skipping 2025/04/19 05:31:26 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:26 DEBUG : both14: Unchanged skipping 2025/04/19 05:31:26 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:26 DEBUG : both15: Unchanged skipping 2025/04/19 05:31:26 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:26 DEBUG : both17: Unchanged skipping 2025/04/19 05:31:26 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:26 DEBUG : both16: Unchanged skipping 2025/04/19 05:31:27 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:27 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:27 DEBUG : both2: Unchanged skipping 2025/04/19 05:31:27 DEBUG : both19: Unchanged skipping 2025/04/19 05:31:27 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:27 DEBUG : both3: Unchanged skipping 2025/04/19 05:31:27 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:27 DEBUG : both4: Unchanged skipping 2025/04/19 05:31:27 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:27 DEBUG : both5: Unchanged skipping 2025/04/19 05:31:27 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:27 DEBUG : both6: Unchanged skipping 2025/04/19 05:31:31 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:31 DEBUG : both1: Unchanged skipping 2025/04/19 05:31:31 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:31 DEBUG : both9: Unchanged skipping 2025/04/19 05:31:31 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:31 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/04/19 05:31:32 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:32 DEBUG : both18: Unchanged skipping 2025/04/19 05:31:32 DEBUG : only0: md5 = 08f0334a8e7e3485211a7a74b575c276 OK 2025/04/19 05:31:32 INFO : only0: Copied (replaced existing) 2025/04/19 05:31:32 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:32 DEBUG : both7: Unchanged skipping 2025/04/19 05:31:32 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/19 05:31:32 DEBUG : both8: Unchanged skipping 2025/04/19 05:31:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Waiting for transfers to finish 2025/04/19 05:31:32 DEBUG : only10: md5 = 4c2b31c2ab57c03a16bce20207272b64 OK 2025/04/19 05:31:32 INFO : only10: Copied (replaced existing) 2025/04/19 05:31:37 DEBUG : only13: md5 = 2648f0f862cdecb3c8d5fd5b3757dfee OK 2025/04/19 05:31:37 INFO : only13: Copied (replaced existing) 2025/04/19 05:31:37 DEBUG : only14: md5 = ad3f502aa80838bd128e61d41e463eab OK 2025/04/19 05:31:37 INFO : only14: Copied (replaced existing) 2025/04/19 05:31:42 DEBUG : only1: md5 = 0e530f6a8f088f2d3c4a3121e871105e OK 2025/04/19 05:31:42 INFO : only1: Copied (replaced existing) 2025/04/19 05:31:42 DEBUG : only11: md5 = f7af1d8b06ae533ac85a33766cb61990 OK 2025/04/19 05:31:42 INFO : only11: Copied (replaced existing) 2025/04/19 05:31:42 DEBUG : only12: md5 = c40ddd40b8da14b5187b98bf4a3e2c5e OK 2025/04/19 05:31:42 INFO : only12: Copied (replaced existing) 2025/04/19 05:31:42 DEBUG : only18: md5 = 8aadc34bb0815575677134d134ef4d2c OK 2025/04/19 05:31:42 INFO : only18: Copied (replaced existing) 2025/04/19 05:31:42 DEBUG : only17: md5 = 33053310f64953bd4851affb0e689e84 OK 2025/04/19 05:31:42 INFO : only17: Copied (replaced existing) 2025/04/19 05:31:42 DEBUG : only19: md5 = 891a8218d5ee6fa1e47630b273d3ae68 OK 2025/04/19 05:31:42 INFO : only19: Copied (replaced existing) 2025/04/19 05:31:42 DEBUG : only15: md5 = bf288bdb1bbb31f52a0d8b156bf803a7 OK 2025/04/19 05:31:42 INFO : only15: Copied (replaced existing) 2025/04/19 05:31:43 DEBUG : only3: md5 = 00201d7d402dd42979b4606fa9d6b6d3 OK 2025/04/19 05:31:43 INFO : only3: Copied (replaced existing) 2025/04/19 05:31:43 DEBUG : only5: md5 = 45e086294358cf594809cae092664e6b OK 2025/04/19 05:31:43 INFO : only5: Copied (replaced existing) 2025/04/19 05:31:47 DEBUG : only16: md5 = 42255188b91243a3ef6aaa66b01c19ab OK 2025/04/19 05:31:47 INFO : only16: Copied (replaced existing) 2025/04/19 05:31:47 DEBUG : only2: md5 = 5313001b77277036ec44bc09de842bbb OK 2025/04/19 05:31:47 INFO : only2: Copied (replaced existing) 2025/04/19 05:31:52 DEBUG : only7: md5 = b5bfbfc63870fbd23df8a2b3e33dde43 OK 2025/04/19 05:31:52 INFO : only7: Copied (replaced existing) 2025/04/19 05:31:52 DEBUG : only9: md5 = b3de0f8bab416cd383ed3e450095e85f OK 2025/04/19 05:31:52 INFO : only9: Copied (replaced existing) 2025/04/19 05:31:53 DEBUG : only4: md5 = 7e5f1f4764eb022c5e879b3d7b9dd2ca OK 2025/04/19 05:31:53 INFO : only4: Copied (replaced existing) 2025/04/19 05:31:53 DEBUG : only6: md5 = c6957c7ce26a6e6834171c05b707d447 OK 2025/04/19 05:31:53 INFO : only6: Copied (replaced existing) 2025/04/19 05:31:57 DEBUG : only8: md5 = 852ba44768be09e5f598e6be2646594e OK 2025/04/19 05:31:57 INFO : only8: Copied (replaced existing) 2025/04/19 05:31:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (373.60s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:35:01 DEBUG : empty_dir: Making directory with metadata 2025/04/19 05:35:01 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/19 05:35:01 DEBUG : empty_on_remote: Making directory with metadata 2025/04/19 05:35:01 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/19 05:35:01 INFO : empty_on_remote: Making directory 2025/04/19 05:35:01 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:35:07 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/04/19 05:35:07 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/04/19 05:35:07 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/04/19 05:35:07 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTime (22.78s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:35:24 DEBUG : empty_dir: Making directory with metadata 2025/04/19 05:35:24 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/19 05:35:24 DEBUG : empty_on_remote: Making directory with metadata 2025/04/19 05:35:24 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/19 05:35:24 INFO : empty_on_remote: Making directory 2025/04/19 05:35:24 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:35:29 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/04/19 05:35:29 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/04/19 05:35:29 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/04/19 05:35:29 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/04/19 05:35:29 INFO : empty_dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (31.87s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:35:56 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/19 05:35:56 INFO : sub dir: Making directory 2025/04/19 05:35:56 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (2.69s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" 2025/04/19 05:35:58 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/19 05:35:58 INFO : sub dir: Making directory 2025/04/19 05:35:58 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya'", Local "Local file system at /tmp/rclone8866414", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (2.34s) PASS 2025/04/19 05:36:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zufotuq0ziya': Purge remote 2025/04/19 05:36:01 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 51m14.871219673s (try 1/5)