"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2024/11/27 04:53:03 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito" 2024/11/27 04:53:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/27 04:53:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito.bin" 2024/11/27 04:53:04 DEBUG : Swift container crypt path rclone-test-bozodiz0mito.bin: Auto set use_segments_container to true 2024/11/27 04:53:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito" 2024/11/27 04:53:05 DEBUG : Swift container crypt path rclone-test-bozodiz0mito: Auto set use_segments_container to true 2024/11/27 04:53:05 DEBUG : Creating backend with remote "/tmp/rclone448413988" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.02s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:06 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:06 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2024/11/27 04:53:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.59s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:06 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/27 04:53:06 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:06 DEBUG : sub dir/hello world: md5 = 98068961ad6b147093d422e2e611b82d OK 2024/11/27 04:53:06 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (1.23s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.09s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.09s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:07 DEBUG : Creating backend with remote "/non-existing" 2024/11/27 04:53:08 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2024/11/27 04:53:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.36s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:08 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:08 DEBUG : sub dir/hello world: md5 = 06c77620bdb6aece6b4a9c5f65e5388e OK 2024/11/27 04:53:08 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyNoTraverse (0.97s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:09 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Running all checks before starting transfers 2024/11/27 04:53:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:09 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Checks finished, now starting transfers 2024/11/27 04:53:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:09 DEBUG : sub dir/hello world: md5 = 5d070597a9fa2e026f0ed3ce5598b187 OK 2024/11/27 04:53:09 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyCheckFirst (0.90s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:10 ERROR : Ignoring --no-traverse with sync 2024/11/27 04:53:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:10 DEBUG : sub dir/hello world: md5 = dad0eb83709939be41f633281c4e92b2 OK 2024/11/27 04:53:10 INFO : sub dir/hello world: Copied (new) 2024/11/27 04:53:10 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncNoTraverse (1.09s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:11 DEBUG : hello world2: Need to transfer - File not found at Destination 2024/11/27 04:53:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:11 DEBUG : hello world2: md5 = d4ec3b1407fc7f89ed37256108c5bf73 OK 2024/11/27 04:53:11 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyWithDepth (1.12s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:12 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:53:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:13 DEBUG : potato2: md5 = b99a71b42a49b134db951eb9bea2260c OK 2024/11/27 04:53:13 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (1.39s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:13 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:53:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:13 DEBUG : potato2: md5 = 4e7eef59b33ac3ba3e084b360fabfe71 OK 2024/11/27 04:53:13 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (0.95s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:14 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/11/27 04:53:14 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/27 04:53:14 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2024/11/27 04:53:14 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/27 04:53:14 DEBUG : sub dir: Making directory 2024/11/27 04:53:14 DEBUG : sub dir2: Making directory 2024/11/27 04:53:14 DEBUG : sub dir2/sub sub dir2: Making directory 2024/11/27 04:53:14 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:14 DEBUG : sub dir/hello world: md5 = e7d5af6ad4887186534b2297c57032ea OK 2024/11/27 04:53:14 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2024/11/27 04:53:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (1.06s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:15 DEBUG : sub dir2: Making directory 2024/11/27 04:53:15 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/11/27 04:53:15 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/27 04:53:15 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:15 DEBUG : sub dir/hello world: md5 = c7e611d84c6dd6301c161c42ee8795df OK 2024/11/27 04:53:15 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (0.68s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:16 DEBUG : sub dir2: Making directory with metadata 2024/11/27 04:53:16 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/27 04:53:16 DEBUG : sub dir: Making directory 2024/11/27 04:53:16 DEBUG : sub dir2: Making directory 2024/11/27 04:53:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:16 DEBUG : sub dir/hello world: md5 = 236845f00152fb65958cf997dd39d39a OK 2024/11/27 04:53:16 INFO : sub dir/hello world: Copied (new) 2024/11/27 04:53:16 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2024/11/27 04:53:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2024/11/27 04:53:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.09s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.18s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:17 DEBUG : sub dir2: Making directory 2024/11/27 04:53:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:17 DEBUG : sub dir/hello world: md5 = f15011d3c00c3131638cee8352c6d91c OK 2024/11/27 04:53:17 INFO : sub dir/hello world: Copied (new) 2024/11/27 04:53:17 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (0.77s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:18 DEBUG : sub dir2: Making directory with metadata 2024/11/27 04:53:18 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/27 04:53:18 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/27 04:53:18 DEBUG : sub dir: Making directory 2024/11/27 04:53:18 DEBUG : sub dir2: Making directory 2024/11/27 04:53:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:18 DEBUG : sub dir/hello world: md5 = 9f3c45fb2a6ec5423fa58db5706f43c1 OK 2024/11/27 04:53:18 INFO : sub dir/hello world: Copied (new) 2024/11/27 04:53:18 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2024/11/27 04:53:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.07s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.13s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:19 DEBUG : sub dir2: Making directory 2024/11/27 04:53:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:20 DEBUG : sub dir/hello world: md5 = ca99a5ccc456294f8d50272c33d19c8b OK 2024/11/27 04:53:20 INFO : sub dir/hello world: Copied (new) 2024/11/27 04:53:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (0.92s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:20 DEBUG : sub dir/hello world: md5 = aa67be0acdfb3708f9fd6202fed29d39 OK 2024/11/27 04:53:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-jexuneg4rabo" 2024/11/27 04:53:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jexuneg4rabo.bin" 2024/11/27 04:53:21 DEBUG : Swift container crypt path rclone-test-jexuneg4rabo.bin: Auto set use_segments_container to true 2024/11/27 04:53:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jexuneg4rabo" 2024/11/27 04:53:22 DEBUG : Swift container crypt path rclone-test-jexuneg4rabo: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito' -> Encrypted drive 'TestCryptSwift:rclone-test-jexuneg4rabo' 2024/11/27 04:53:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jexuneg4rabo': Waiting for checks to finish 2024/11/27 04:53:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jexuneg4rabo': Waiting for transfers to finish 2024/11/27 04:53:24 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jexuneg4rabo': Purge remote 2024/11/27 04:53:24 DEBUG : Waiting for deletions to finish 2024/11/27 04:53:24 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (4.61s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:25 DEBUG : sub dir/hello world: md5 = 60bd3fa1c11d8729761b54450aabe63c OK 2024/11/27 04:53:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:25 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/27 04:53:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:25 DEBUG : sub dir/hello world: md5 = 03c37974415037f547411d9a33aae133 OK 2024/11/27 04:53:25 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyOverSelf (1.40s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:26 DEBUG : sub dir/hello world: md5 = 6a6300515dfeafa873495c5628a6d9ac OK 2024/11/27 04:53:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-jibujad3qovo" 2024/11/27 04:53:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jibujad3qovo.bin" 2024/11/27 04:53:27 DEBUG : Swift container crypt path rclone-test-jibujad3qovo.bin: Auto set use_segments_container to true 2024/11/27 04:53:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jibujad3qovo" 2024/11/27 04:53:28 DEBUG : Swift container crypt path rclone-test-jibujad3qovo: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito' -> Encrypted drive 'TestCryptSwift:rclone-test-jibujad3qovo' 2024/11/27 04:53:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jibujad3qovo': Waiting for checks to finish 2024/11/27 04:53:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jibujad3qovo': Waiting for transfers to finish 2024/11/27 04:53:29 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:30 DEBUG : sub dir/hello world: md5 = 10b18eaa6d4347d8c1d1a11800503a9c OK 2024/11/27 04:53:30 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/27 04:53:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jibujad3qovo': Waiting for checks to finish 2024/11/27 04:53:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jibujad3qovo': Waiting for transfers to finish 2024/11/27 04:53:30 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jibujad3qovo': Purge remote 2024/11/27 04:53:31 DEBUG : Waiting for deletions to finish 2024/11/27 04:53:31 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (5.43s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:32 DEBUG : sub dir/hello world: md5 = 54f8a739396d7eeba9ac8f517e5baef8 OK 2024/11/27 04:53:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:32 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/27 04:53:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:32 DEBUG : sub dir/hello world: md5 = 7e207f040ba2e2160e7c70a11c900110 OK 2024/11/27 04:53:32 INFO : sub dir/hello world: Copied (replaced existing) 2024/11/27 04:53:32 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestMoveOverSelf (1.35s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:33 DEBUG : sub dir/hello world: md5 = a9bbce81e8e322d6202d6b872c3dcfa0 OK 2024/11/27 04:53:33 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-puzened5yuru" 2024/11/27 04:53:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-puzened5yuru.bin" 2024/11/27 04:53:34 DEBUG : Swift container crypt path rclone-test-puzened5yuru.bin: Auto set use_segments_container to true 2024/11/27 04:53:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-puzened5yuru" 2024/11/27 04:53:35 DEBUG : Swift container crypt path rclone-test-puzened5yuru: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito' -> Encrypted drive 'TestCryptSwift:rclone-test-puzened5yuru' 2024/11/27 04:53:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puzened5yuru': Waiting for checks to finish 2024/11/27 04:53:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puzened5yuru': Waiting for transfers to finish 2024/11/27 04:53:36 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:36 DEBUG : sub dir/hello world: md5 = 38fe3fe897fb4f58660aa05ab0a54bcb OK 2024/11/27 04:53:37 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/27 04:53:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puzened5yuru': Waiting for checks to finish 2024/11/27 04:53:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puzened5yuru': Waiting for transfers to finish 2024/11/27 04:53:37 INFO : sub dir/hello world: Copied (server-side copy) 2024/11/27 04:53:37 INFO : sub dir/hello world: Deleted 2024/11/27 04:53:38 DEBUG : sub dir/hello world: md5 = dd0d12ea425c0a0839b7b51c45be1685 OK 2024/11/27 04:53:38 DEBUG : testing file moves 2024/11/27 04:53:38 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2024/11/27 04:53:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puzened5yuru': Waiting for checks to finish 2024/11/27 04:53:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puzened5yuru': Waiting for transfers to finish 2024/11/27 04:53:39 INFO : sub dir/hello world: Copied (server-side copy) 2024/11/27 04:53:39 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puzened5yuru': Purge remote 2024/11/27 04:53:39 DEBUG : Waiting for deletions to finish 2024/11/27 04:53:39 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (6.99s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:40 DEBUG : sub dir/hello world: md5 = 4b8e3e8b866a66a9d00a171963d0f270 OK 2024/11/27 04:53:40 ERROR : : error listing: directory not found 2024/11/27 04:53:40 DEBUG : Local file system at /tmp/rclone448413988: Making directory 2024/11/27 04:53:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyAfterDelete (1.10s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:41 DEBUG : sub dir/hello world: md5 = ad3edb63a9a33e12d8622d102db4c349 OK 2024/11/27 04:53:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:53:42 DEBUG : Local file system at /tmp/rclone448413988: Waiting for checks to finish 2024/11/27 04:53:42 DEBUG : Local file system at /tmp/rclone448413988: Waiting for transfers to finish 2024/11/27 04:53:42 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2024/11/27 04:53:42 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyRedownload (1.33s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:42 DEBUG : check sum: Need to transfer - File not found at Destination 2024/11/27 04:53:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:43 DEBUG : check sum: md5 = c509912ee7d3241beae6aace524c267e OK 2024/11/27 04:53:43 INFO : check sum: Copied (new) 2024/11/27 04:53:43 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:43 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2024/11/27 04:53:43 DEBUG : check sum: Size of src and dst objects identical 2024/11/27 04:53:43 DEBUG : check sum: Unchanged skipping 2024/11/27 04:53:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:43 DEBUG : Waiting for deletions to finish 2024/11/27 04:53:43 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (1.50s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:44 DEBUG : sizeonly: Need to transfer - File not found at Destination 2024/11/27 04:53:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:44 DEBUG : sizeonly: md5 = 98d07c3d14928b350e7908965e61803e OK 2024/11/27 04:53:44 INFO : sizeonly: Copied (new) 2024/11/27 04:53:44 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:45 DEBUG : sizeonly: Sizes identical 2024/11/27 04:53:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:45 DEBUG : sizeonly: Unchanged skipping 2024/11/27 04:53:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:45 DEBUG : Waiting for deletions to finish 2024/11/27 04:53:45 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncSizeOnly (1.96s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:46 DEBUG : ignore-size: Need to transfer - File not found at Destination 2024/11/27 04:53:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:46 DEBUG : ignore-size: md5 = 91f2b3aa1cb2ca807eff98a2fb0edfd7 OK 2024/11/27 04:53:46 INFO : ignore-size: Copied (new) 2024/11/27 04:53:46 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:46 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:53:46 DEBUG : ignore-size: Unchanged skipping 2024/11/27 04:53:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:46 DEBUG : Waiting for deletions to finish 2024/11/27 04:53:46 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (1.42s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:47 DEBUG : existing: md5 = 991d31aee7bd7a7798b9a8026979db44 OK 2024/11/27 04:53:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:48 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:53:48 DEBUG : existing: Unchanged skipping 2024/11/27 04:53:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:48 DEBUG : Waiting for deletions to finish 2024/11/27 04:53:48 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:48 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2024/11/27 04:53:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:48 DEBUG : existing: md5 = aff0bea39cd331fab88eb3b0293e719b OK 2024/11/27 04:53:48 INFO : existing: Copied (replaced existing) 2024/11/27 04:53:48 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (1.77s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:49 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/27 04:53:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:49 DEBUG : existing: md5 = b747be4c719387e6221ed9887de2e760 OK 2024/11/27 04:53:49 INFO : existing: Copied (new) 2024/11/27 04:53:49 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:49 DEBUG : existing: Destination exists, skipping 2024/11/27 04:53:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:49 DEBUG : Waiting for deletions to finish 2024/11/27 04:53:49 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (1.42s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:51 DEBUG : b/potato: md5 = 3aae69218edc4bb0354038b278424fa4 OK 2024/11/27 04:53:51 DEBUG : c/non empty space: md5 = 1cc907456bd1b0065ad2d3fcffa34b1b OK 2024/11/27 04:53:51 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/11/27 04:53:52 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/27 04:53:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:52 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:53:52 DEBUG : c/non empty space: Unchanged skipping 2024/11/27 04:53:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:52 DEBUG : a/potato2: md5 = 9a459069bc1123fa7edca1c44b455aee OK 2024/11/27 04:53:52 INFO : a/potato2: Copied (new) 2024/11/27 04:53:52 DEBUG : Waiting for deletions to finish 2024/11/27 04:53:53 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (3.18s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:54 DEBUG : empty space: md5 = 9635c1e0b038624d3590d37978d3485a OK 2024/11/27 04:53:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:55 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 2024/11/27 04:53:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:55 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2024/11/27 04:53:55 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:55 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 2024/11/27 04:53:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:55 DEBUG : empty space: md5 = 4e969ad9e169ab5c64f7f97c13d0bdb4 OK 2024/11/27 04:53:55 INFO : empty space: Copied (replaced existing) 2024/11/27 04:53:55 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (2.47s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:1016: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.09s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:56 DEBUG : foo: md5 = 557ede3037049be81bd56720efff71f6 OK 2024/11/27 04:53:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:57 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 2024/11/27 04:53:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:57 DEBUG : foo: md5 = bd7dbf66fc7aed5d0b651fd280d4da9c OK 2024/11/27 04:53:57 INFO : foo: Copied (replaced existing) 2024/11/27 04:53:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (1.45s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:53:58 DEBUG : empty space: md5 = 578984cdb72d30ebe83ff190f1152ff6 OK 2024/11/27 04:53:58 DEBUG : potato: Need to transfer - File not found at Destination 2024/11/27 04:53:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:53:58 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:53:58 DEBUG : empty space: Unchanged skipping 2024/11/27 04:53:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:53:59 DEBUG : potato: md5 = 90652a7e8accf15ceb35912bc8e07cce OK 2024/11/27 04:53:59 INFO : potato: Copied (new) 2024/11/27 04:53:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (2.30s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:00 DEBUG : potato: md5 = bb61817a0f9c7a884a18d16fa20822f9 OK 2024/11/27 04:54:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:00 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2024/11/27 04:54:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:00 DEBUG : potato: md5 = c14f303512f3126ab1045022f5be00a6 OK 2024/11/27 04:54:00 INFO : potato: Copied (replaced existing) 2024/11/27 04:54:00 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (1.42s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:01 DEBUG : potato: md5 = 33d4d1ae374892310638fb69a62a9406 OK 2024/11/27 04:54:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:02 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 2024/11/27 04:54:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:02 DEBUG : potato: md5 = 519747b5efb1ce3172533edf848bc1e1 OK 2024/11/27 04:54:02 INFO : potato: Copied (replaced existing) 2024/11/27 04:54:02 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (1.47s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:03 DEBUG : potato: md5 = c8079143a9899d0ec1ad3ad9fd82120e OK 2024/11/27 04:54:03 DEBUG : empty space: md5 = b8834a620900258a0b1355b7ace9257d OK 2024/11/27 04:54:03 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:03 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2024/11/27 04:54:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:03 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:03 DEBUG : empty space: Unchanged skipping 2024/11/27 04:54:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:03 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:03 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (1.39s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:04 DEBUG : potato: md5 = 7b30ae181617b4cf7bf5eeed10efcb3b OK 2024/11/27 04:54:05 DEBUG : empty space: md5 = 3ff684e63a82ce1bf8e98701f218e147 OK 2024/11/27 04:54:05 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:05 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:05 DEBUG : empty space: Unchanged skipping 2024/11/27 04:54:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:05 DEBUG : potato2: md5 = a65cbe78c2afacd6c72a5bd04837d9dd OK 2024/11/27 04:54:05 INFO : potato2: Copied (new) 2024/11/27 04:54:05 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:05 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.03s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:06 DEBUG : b/potato: md5 = 959cca6ae68f0c1946ca738ce8c2f5e1 OK 2024/11/27 04:54:06 DEBUG : c/non empty space: md5 = fdd3e7d2127cfb6f17d60b45f61e7298 OK 2024/11/27 04:54:06 DEBUG : d: Making directory 2024/11/27 04:54:06 DEBUG : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2024/11/27 04:54:07 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:07 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:07 DEBUG : c/non empty space: Unchanged skipping 2024/11/27 04:54:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:07 DEBUG : a/potato2: md5 = 521639781b23c5789c80c422cc029aad OK 2024/11/27 04:54:07 INFO : a/potato2: Copied (new) 2024/11/27 04:54:07 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:07 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (2.19s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:09 DEBUG : b/potato: md5 = 0d332e566d7023290281589eef31468b OK 2024/11/27 04:54:09 DEBUG : c/non empty space: md5 = 115a9c60a7aca0c4151d992519608f0f OK 2024/11/27 04:54:09 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/11/27 04:54:09 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:09 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:09 DEBUG : c/non empty space: Unchanged skipping 2024/11/27 04:54:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:09 DEBUG : a/potato2: md5 = 50ed8c6e48b17b162ea959ccd5aa72ad OK 2024/11/27 04:54:09 INFO : a/potato2: Copied (new) 2024/11/27 04:54:09 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': not deleting files as there were IO errors 2024/11/27 04:54:09 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (2.12s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:11 DEBUG : potato: md5 = b2769e354c6acaa869c85b1b1191acf9 OK 2024/11/27 04:54:11 DEBUG : empty space: md5 = 0e5f610bbad8ba667333f6cb876d953d OK 2024/11/27 04:54:11 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:12 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:12 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:12 DEBUG : empty space: Unchanged skipping 2024/11/27 04:54:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:12 INFO : potato: Deleted 2024/11/27 04:54:12 DEBUG : potato2: md5 = 811c01ed6f6d298d4002c8e4fc76a339 OK 2024/11/27 04:54:12 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (2.62s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:13 DEBUG : potato: md5 = 5e0541d056c26b64b496c5077d4ddeca OK 2024/11/27 04:54:13 DEBUG : empty space: md5 = 6aadd498c9e64ff8e057634de3f0e64d OK 2024/11/27 04:54:14 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:14 INFO : potato: Deleted 2024/11/27 04:54:14 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:14 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:14 DEBUG : empty space: Unchanged skipping 2024/11/27 04:54:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:14 DEBUG : potato2: md5 = 0ad7d0e29053d17d7a559204aeb05075 OK 2024/11/27 04:54:14 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (2.11s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:15 DEBUG : potato: md5 = a0353c5b0d465a87d45b1ee9f0e1583b OK 2024/11/27 04:54:16 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:16 DEBUG : potato2: md5 = 54ebb6bcda8e7fb77fb3f8c450dceafd OK 2024/11/27 04:54:16 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (1.43s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:17 DEBUG : potato2: md5 = c7a8ded6cab42e9f53ccbd0263b126ed OK 2024/11/27 04:54:17 DEBUG : empty space: md5 = 3b8622a10e4eb3b61a58e3a10d599e5b OK 2024/11/27 04:54:17 DEBUG : enormous: Excluded (Size Filter) 2024/11/27 04:54:17 DEBUG : enormous: Excluded 2024/11/27 04:54:17 DEBUG : potato2: Excluded (Size Filter) 2024/11/27 04:54:17 DEBUG : potato2: Excluded 2024/11/27 04:54:17 DEBUG : potato2: Excluded (Size Filter) 2024/11/27 04:54:17 DEBUG : potato2: Excluded 2024/11/27 04:54:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:17 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:17 DEBUG : empty space: Unchanged skipping 2024/11/27 04:54:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:17 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:17 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:18 DEBUG : enormous: Excluded (Size Filter) 2024/11/27 04:54:18 DEBUG : enormous: Excluded 2024/11/27 04:54:18 DEBUG : potato2: Excluded (Size Filter) 2024/11/27 04:54:18 DEBUG : potato2: Excluded 2024/11/27 04:54:18 DEBUG : potato2: Excluded (Size Filter) 2024/11/27 04:54:18 DEBUG : potato2: Excluded 2024/11/27 04:54:18 DEBUG : Local file system at /tmp/rclone448413988: Waiting for checks to finish 2024/11/27 04:54:18 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:18 DEBUG : empty space: Unchanged skipping 2024/11/27 04:54:18 DEBUG : Local file system at /tmp/rclone448413988: Waiting for transfers to finish 2024/11/27 04:54:18 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:18 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncWithExclude (2.04s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:19 DEBUG : potato2: md5 = 9758e2b79611c3ff0c045d9a1b440bd3 OK 2024/11/27 04:54:19 DEBUG : empty space: md5 = 63a395451e2025039869baeeda4fbfc4 OK 2024/11/27 04:54:19 DEBUG : enormous: md5 = 14dc0efe8f9cfd96c7812f736618ccc9 OK 2024/11/27 04:54:20 DEBUG : enormous: Excluded (Size Filter) 2024/11/27 04:54:20 DEBUG : enormous: Excluded 2024/11/27 04:54:20 DEBUG : potato2: Excluded (Size Filter) 2024/11/27 04:54:20 DEBUG : potato2: Excluded 2024/11/27 04:54:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:20 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:20 DEBUG : empty space: Unchanged skipping 2024/11/27 04:54:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:20 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:20 INFO : enormous: Deleted 2024/11/27 04:54:20 INFO : potato2: Deleted 2024/11/27 04:54:20 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:21 DEBUG : Local file system at /tmp/rclone448413988: Waiting for checks to finish 2024/11/27 04:54:21 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:21 DEBUG : empty space: Unchanged skipping 2024/11/27 04:54:21 DEBUG : Local file system at /tmp/rclone448413988: Waiting for transfers to finish 2024/11/27 04:54:21 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:21 INFO : enormous: Deleted 2024/11/27 04:54:21 INFO : potato2: Deleted 2024/11/27 04:54:21 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (2.57s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:22 DEBUG : one: md5 = ef63ac4ac0df8da41c3b7db906f699d2 OK 2024/11/27 04:54:22 DEBUG : two: md5 = e8494d1b5f8bc596e1f9d15fa629a55f OK 2024/11/27 04:54:23 DEBUG : three: md5 = 76df3f2be437fd9e12aa8d9cb07ce798 OK 2024/11/27 04:54:24 DEBUG : four: md5 = f6cf842a3a6ab6e6ec12b19be6f27968 OK 2024/11/27 04:54:24 DEBUG : five: Need to transfer - File not found at Destination 2024/11/27 04:54:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:24 DEBUG : three: Sizes identical 2024/11/27 04:54:24 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2024/11/27 04:54:24 DEBUG : four: Sizes differ (src 4 vs dst 8) 2024/11/27 04:54:24 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2024/11/27 04:54:24 DEBUG : one: Destination is newer than source, skipping 2024/11/27 04:54:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:24 DEBUG : four: md5 = 2891f51a7120379a11993531a5d65837 OK 2024/11/27 04:54:24 INFO : four: Copied (replaced existing) 2024/11/27 04:54:24 DEBUG : two: md5 = c62a2867e1941e70ac31985c763fde1d OK 2024/11/27 04:54:24 INFO : two: Copied (replaced existing) 2024/11/27 04:54:24 DEBUG : five: md5 = 6a53b6fc007e7b8858bc9d7d667dbfcd OK 2024/11/27 04:54:24 INFO : five: Copied (new) 2024/11/27 04:54:24 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (4.57s) === 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-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2024/11/27 04:54:26 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Ignoring --track-renames as the source and destination do not have a common hash 2024/11/27 04:54:26 DEBUG : potato: Need to transfer - File not found at Destination 2024/11/27 04:54:26 DEBUG : yam: Need to transfer - File not found at Destination 2024/11/27 04:54:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:26 DEBUG : potato: md5 = 70fdcb1b021178126c92d6b71c9fd405 OK 2024/11/27 04:54:26 INFO : potato: Copied (new) 2024/11/27 04:54:26 DEBUG : yam: md5 = ae182ccdb08be66a798ff27788826c2a OK 2024/11/27 04:54:26 INFO : yam: Copied (new) 2024/11/27 04:54:26 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:26 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Ignoring --track-renames as the source and destination do not have a common hash 2024/11/27 04:54:27 DEBUG : yaml: Need to transfer - File not found at Destination 2024/11/27 04:54:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:27 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:27 DEBUG : potato: Unchanged skipping 2024/11/27 04:54:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:27 DEBUG : yaml: md5 = f8c39b3fb45335c6b9199e4cfee4dd9d OK 2024/11/27 04:54:27 INFO : yaml: Copied (new) 2024/11/27 04:54:27 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:27 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (2.35s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2024/11/27 04:54:28 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Making map for --track-renames 2024/11/27 04:54:28 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Finished making map for --track-renames 2024/11/27 04:54:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:28 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/27 04:54:28 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/11/27 04:54:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for renames to finish 2024/11/27 04:54:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:28 DEBUG : yam: md5 = 90be8473ca643e01cb102345728cd003 OK 2024/11/27 04:54:28 INFO : yam: Copied (new) 2024/11/27 04:54:29 DEBUG : potato: md5 = 620fb4b2d9791cb66481e2fc5aae4fa3 OK 2024/11/27 04:54:29 INFO : potato: Copied (new) 2024/11/27 04:54:29 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:29 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Making map for --track-renames 2024/11/27 04:54:29 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Finished making map for --track-renames 2024/11/27 04:54:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:29 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:29 DEBUG : potato: Unchanged skipping 2024/11/27 04:54:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for renames to finish 2024/11/27 04:54:29 INFO : yam: Copied (server-side copy) to: yaml 2024/11/27 04:54:29 INFO : yam: Deleted 2024/11/27 04:54:29 INFO : yaml: Renamed from "yam" 2024/11/27 04:54:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:29 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (2.76s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2024/11/27 04:54:31 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Making map for --track-renames 2024/11/27 04:54:31 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Finished making map for --track-renames 2024/11/27 04:54:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:31 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/27 04:54:31 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/11/27 04:54:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for renames to finish 2024/11/27 04:54:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:31 DEBUG : potato: md5 = 397c901b6169561165b1cc585e787ebf OK 2024/11/27 04:54:31 INFO : potato: Copied (new) 2024/11/27 04:54:32 DEBUG : sub/yam: md5 = a268b007e19cbcf74c29c38b81bcf947 OK 2024/11/27 04:54:32 INFO : sub/yam: Copied (new) 2024/11/27 04:54:32 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:32 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:32 DEBUG : potato: Unchanged skipping 2024/11/27 04:54:32 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Making map for --track-renames 2024/11/27 04:54:32 INFO : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Finished making map for --track-renames 2024/11/27 04:54:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for renames to finish 2024/11/27 04:54:32 INFO : sub/yam: Copied (server-side copy) to: yam 2024/11/27 04:54:33 INFO : sub/yam: Deleted 2024/11/27 04:54:33 INFO : yam: Renamed from "sub/yam" 2024/11/27 04:54:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:33 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (2.72s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:34 DEBUG : Creating backend with remote "/tmp/rclone448413988/dir1" 2024/11/27 04:54:34 DEBUG : Creating backend with remote "/tmp/rclone448413988/dir2" 2024/11/27 04:54:34 DEBUG : Local file system at /tmp/rclone448413988/dir2: Using server-side directory move 2024/11/27 04:54:34 INFO : Local file system at /tmp/rclone448413988/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/11/27 04:54:34 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/11/27 04:54:34 DEBUG : Local file system at /tmp/rclone448413988/dir2: Waiting for checks to finish 2024/11/27 04:54:34 DEBUG : Local file system at /tmp/rclone448413988/dir2: Waiting for transfers to finish 2024/11/27 04:54:34 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.10s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:54:34 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/11/27 04:54:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:34 DEBUG : sub dir/hello world: md5 = 19c7bd3b7ba31211e4fb94b08d3b634e OK 2024/11/27 04:54:34 INFO : sub dir/hello world: Copied (new) 2024/11/27 04:54:34 INFO : sub dir/hello world: Deleted 2024/11/27 04:54:35 DEBUG : nested/sub dir/file: md5 = 03acc15eb5f146904e518171596ee555 OK 2024/11/27 04:54:35 INFO : nested/sub dir/file: Copied (new) 2024/11/27 04:54:35 INFO : nested/sub dir/file: Deleted 2024/11/27 04:54:35 INFO : sub dir: Removing directory 2024/11/27 04:54:35 INFO : nested/sub dir: Removing directory 2024/11/27 04:54:35 INFO : nested: Removing directory 2024/11/27 04:54:35 DEBUG : Local file system at /tmp/rclone448413988: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (1.60s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/27 04:54:35 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/11/27 04:54:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:36 DEBUG : nested/sub dir/file: md5 = de9470d5518767e5d454388fa0ebbd6c OK 2024/11/27 04:54:36 INFO : nested/sub dir/file: Copied (new) 2024/11/27 04:54:36 INFO : nested/sub dir/file: Deleted 2024/11/27 04:54:36 DEBUG : sub dir/hello world: md5 = 702e3ad3cc5c439f6c4e63a21551d8d8 OK 2024/11/27 04:54:36 INFO : sub dir/hello world: Copied (new) 2024/11/27 04:54:36 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (1.48s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:37 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/27 04:54:37 DEBUG : existing-b: Need to transfer - File not found at Destination 2024/11/27 04:54:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:37 DEBUG : existing: md5 = f735154e8486b45d3cfcda94bad50527 OK 2024/11/27 04:54:37 INFO : existing: Copied (new) 2024/11/27 04:54:37 INFO : existing: Deleted 2024/11/27 04:54:37 DEBUG : existing-b: md5 = 43c767df927604be166fa076a48fa50c OK 2024/11/27 04:54:37 INFO : existing-b: Copied (new) 2024/11/27 04:54:37 INFO : existing-b: Deleted 2024/11/27 04:54:38 DEBUG : existing: Destination exists, skipping 2024/11/27 04:54:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:54:38 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2024/11/27 04:54:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:54:38 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (2.15s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:39 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-juvocan2tata" 2024/11/27 04:54:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-juvocan2tata.bin" 2024/11/27 04:54:40 DEBUG : Swift container crypt path rclone-test-juvocan2tata.bin: Auto set use_segments_container to true 2024/11/27 04:54:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-juvocan2tata" 2024/11/27 04:54:40 DEBUG : Swift container crypt path rclone-test-juvocan2tata: Auto set use_segments_container to true 2024/11/27 04:54:42 DEBUG : potato2: md5 = c399de657af2c9ddf95e4a6ecb469dcf OK 2024/11/27 04:54:43 DEBUG : empty space: md5 = 99a39e0a8a1ab3e35109b24c28cab27d OK 2024/11/27 04:54:44 DEBUG : potato3: md5 = e1c004484afa445c216ec52d3d31d2c3 OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito' -> Encrypted drive 'TestCryptSwift:rclone-test-juvocan2tata' 2024/11/27 04:54:44 DEBUG : empty space: md5 = e730f63bc53ac46122096edabaf6373b OK 2024/11/27 04:54:45 DEBUG : potato3: md5 = 8c0a896671d40bf69b6a08e875940553 OK 2024/11/27 04:54:45 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:45 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/27 04:54:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-juvocan2tata': Waiting for checks to finish 2024/11/27 04:54:46 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:54:46 DEBUG : empty space: Unchanged skipping 2024/11/27 04:54:47 INFO : empty space: Deleted 2024/11/27 04:54:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-juvocan2tata': Waiting for transfers to finish 2024/11/27 04:54:47 INFO : potato2: Copied (server-side copy) 2024/11/27 04:54:47 INFO : potato3: Copied (server-side copy) 2024/11/27 04:54:47 INFO : potato2: Deleted 2024/11/27 04:54:48 INFO : potato3: Deleted 2024/11/27 04:54:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yubilus9bebu" 2024/11/27 04:54:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yubilus9bebu.bin" 2024/11/27 04:54:49 DEBUG : Swift container crypt path rclone-test-yubilus9bebu.bin: Auto set use_segments_container to true 2024/11/27 04:54:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yubilus9bebu" 2024/11/27 04:54:49 DEBUG : Swift container crypt path rclone-test-yubilus9bebu: Auto set use_segments_container to true 2024/11/27 04:54:50 DEBUG : empty space: Need to transfer - File not found at Destination 2024/11/27 04:54:50 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:50 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/27 04:54:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yubilus9bebu': Waiting for checks to finish 2024/11/27 04:54:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yubilus9bebu': Waiting for transfers to finish 2024/11/27 04:54:51 INFO : empty space: Copied (server-side copy) 2024/11/27 04:54:51 INFO : empty space: Deleted 2024/11/27 04:54:51 INFO : potato2: Copied (server-side copy) 2024/11/27 04:54:51 INFO : potato2: Deleted 2024/11/27 04:54:51 INFO : potato3: Copied (server-side copy) 2024/11/27 04:54:51 INFO : potato3: Deleted 2024/11/27 04:54:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yubilus9bebu': Purge remote 2024/11/27 04:54:52 DEBUG : Waiting for deletions to finish 2024/11/27 04:54:52 INFO : potato2.bin: Deleted 2024/11/27 04:54:52 INFO : empty space.bin: Deleted 2024/11/27 04:54:52 INFO : potato3.bin: Deleted 2024/11/27 04:54:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-juvocan2tata': Purge remote 2024/11/27 04:54:52 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (13.73s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:54:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-moqagex3cogi" 2024/11/27 04:54:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-moqagex3cogi.bin" 2024/11/27 04:54:53 DEBUG : Swift container crypt path rclone-test-moqagex3cogi.bin: Auto set use_segments_container to true 2024/11/27 04:54:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-moqagex3cogi" 2024/11/27 04:54:54 DEBUG : Swift container crypt path rclone-test-moqagex3cogi: Auto set use_segments_container to true 2024/11/27 04:54:55 DEBUG : potato2: md5 = 9940d32362b3e554e368ef5766f8c6b1 OK 2024/11/27 04:54:55 DEBUG : empty space: md5 = 258e1f8a69c87e12aad157007565e317 OK 2024/11/27 04:54:56 DEBUG : potato3: md5 = ca267c75b1b45331c15d9ef44d2123e1 OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito' -> Encrypted drive 'TestCryptSwift:rclone-test-moqagex3cogi' 2024/11/27 04:54:57 DEBUG : empty space: md5 = 2eab739f5bf9b59b221a7818bae8093a OK 2024/11/27 04:54:57 DEBUG : potato3: md5 = a606b22875adce6dabdaee1e7de7b05c OK 2024/11/27 04:54:58 DEBUG : empty space: Excluded (Size Filter) 2024/11/27 04:54:58 DEBUG : empty space: Excluded 2024/11/27 04:54:58 DEBUG : empty space: Excluded (Size Filter) 2024/11/27 04:54:58 DEBUG : empty space: Excluded 2024/11/27 04:54:58 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:54:58 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/27 04:54:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-moqagex3cogi': Waiting for checks to finish 2024/11/27 04:54:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-moqagex3cogi': Waiting for transfers to finish 2024/11/27 04:54:58 INFO : potato3: Copied (server-side copy) 2024/11/27 04:54:58 INFO : potato3: Deleted 2024/11/27 04:54:58 INFO : potato2: Copied (server-side copy) 2024/11/27 04:54:58 INFO : potato2: Deleted 2024/11/27 04:54:59 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-heyoxec9dipi" 2024/11/27 04:54:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-heyoxec9dipi.bin" 2024/11/27 04:54:59 DEBUG : Swift container crypt path rclone-test-heyoxec9dipi.bin: Auto set use_segments_container to true 2024/11/27 04:54:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-heyoxec9dipi" 2024/11/27 04:55:00 DEBUG : Swift container crypt path rclone-test-heyoxec9dipi: Auto set use_segments_container to true 2024/11/27 04:55:00 DEBUG : empty space: Excluded (Size Filter) 2024/11/27 04:55:00 DEBUG : empty space: Excluded 2024/11/27 04:55:00 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:55:00 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/27 04:55:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-heyoxec9dipi': Waiting for checks to finish 2024/11/27 04:55:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-heyoxec9dipi': Waiting for transfers to finish 2024/11/27 04:55:01 INFO : potato3: Copied (server-side copy) 2024/11/27 04:55:01 INFO : potato3: Deleted 2024/11/27 04:55:01 INFO : potato2: Copied (server-side copy) 2024/11/27 04:55:01 INFO : potato2: Deleted 2024/11/27 04:55:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-heyoxec9dipi': Purge remote 2024/11/27 04:55:02 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:02 INFO : potato2.bin: Deleted 2024/11/27 04:55:02 INFO : potato3.bin: Deleted 2024/11/27 04:55:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-moqagex3cogi': Purge remote 2024/11/27 04:55:02 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:02 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (9.91s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:03 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bunajuq9bifi" 2024/11/27 04:55:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bunajuq9bifi.bin" 2024/11/27 04:55:03 DEBUG : Swift container crypt path rclone-test-bunajuq9bifi.bin: Auto set use_segments_container to true 2024/11/27 04:55:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bunajuq9bifi" 2024/11/27 04:55:04 DEBUG : Swift container crypt path rclone-test-bunajuq9bifi: Auto set use_segments_container to true 2024/11/27 04:55:05 DEBUG : potato2: md5 = e92b957c3ecada5651f10dd72ee089ce OK 2024/11/27 04:55:05 DEBUG : empty space: md5 = 4b480c7b5fc2fd6d20c4385f80e94792 OK 2024/11/27 04:55:05 DEBUG : potato3: md5 = 062082b0d76c70d45af02dabffda55f3 OK 2024/11/27 04:55:05 DEBUG : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito' -> Encrypted drive 'TestCryptSwift:rclone-test-bunajuq9bifi' 2024/11/27 04:55:06 DEBUG : empty space: md5 = 6ccaff108da873b949b8faefe5fa7f5c OK 2024/11/27 04:55:07 DEBUG : potato3: md5 = f3918c040ec7140897c03ba75e40a377 OK 2024/11/27 04:55:08 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:55:08 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/27 04:55:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bunajuq9bifi': Waiting for checks to finish 2024/11/27 04:55:08 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:08 DEBUG : empty space: Unchanged skipping 2024/11/27 04:55:08 INFO : empty space: Deleted 2024/11/27 04:55:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bunajuq9bifi': Waiting for transfers to finish 2024/11/27 04:55:08 INFO : potato2: Copied (server-side copy) 2024/11/27 04:55:08 INFO : potato3: Copied (server-side copy) 2024/11/27 04:55:08 INFO : potato3: Deleted 2024/11/27 04:55:09 INFO : potato2: Deleted 2024/11/27 04:55:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-minupiz5roda" 2024/11/27 04:55:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-minupiz5roda.bin" 2024/11/27 04:55:10 DEBUG : Swift container crypt path rclone-test-minupiz5roda.bin: Auto set use_segments_container to true 2024/11/27 04:55:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-minupiz5roda" 2024/11/27 04:55:11 DEBUG : Swift container crypt path rclone-test-minupiz5roda: Auto set use_segments_container to true 2024/11/27 04:55:11 DEBUG : tomatoDir: Making directory 2024/11/27 04:55:11 DEBUG : empty space: Need to transfer - File not found at Destination 2024/11/27 04:55:11 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/27 04:55:11 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/27 04:55:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-minupiz5roda': Waiting for checks to finish 2024/11/27 04:55:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-minupiz5roda': Waiting for transfers to finish 2024/11/27 04:55:12 INFO : empty space: Copied (server-side copy) 2024/11/27 04:55:12 INFO : potato3: Copied (server-side copy) 2024/11/27 04:55:12 INFO : potato3: Deleted 2024/11/27 04:55:12 INFO : empty space: Deleted 2024/11/27 04:55:12 INFO : potato2: Copied (server-side copy) 2024/11/27 04:55:13 INFO : potato2: Deleted 2024/11/27 04:55:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-minupiz5roda': Purge remote 2024/11/27 04:55:13 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:13 INFO : potato3.bin: Deleted 2024/11/27 04:55:13 INFO : potato2.bin: Deleted 2024/11/27 04:55:13 INFO : empty space.bin: Deleted 2024/11/27 04:55:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bunajuq9bifi': Purge remote 2024/11/27 04:55:13 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (11.00s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/rclone-move-test" 2024/11/27 04:55:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-move-test.bin" 2024/11/27 04:55:14 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-move-test.bin: Auto set use_segments_container to true 2024/11/27 04:55:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-move-test" 2024/11/27 04:55:15 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-move-test: Auto set use_segments_container to true 2024/11/27 04:55:16 DEBUG : potato2: md5 = 65bb59536f8e95346bc21ecb587cfdb1 OK --- PASS: TestServerSideMoveOverlap (3.29s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:17 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test" 2024/11/27 04:55:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-sync-test.bin" 2024/11/27 04:55:18 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-sync-test.bin: Auto set use_segments_container to true 2024/11/27 04:55:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-sync-test" 2024/11/27 04:55:18 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncOverlap (2.83s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test" 2024/11/27 04:55:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-sync-test.bin" 2024/11/27 04:55:20 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-sync-test.bin: Auto set use_segments_container to true 2024/11/27 04:55:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-sync-test" 2024/11/27 04:55:21 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-sync-test: Auto set use_segments_container to true 2024/11/27 04:55:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test-include/layer2" 2024/11/27 04:55:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-sync-test-include/layer2.bin" 2024/11/27 04:55:22 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2024/11/27 04:55:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-sync-test-include/layer2" 2024/11/27 04:55:23 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2024/11/27 04:55:23 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test-ignore-file" 2024/11/27 04:55:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-sync-test-ignore-file.bin" 2024/11/27 04:55:24 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2024/11/27 04:55:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/rclone-sync-test-ignore-file" 2024/11/27 04:55:24 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2024/11/27 04:55:26 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = 0b5e00e3178b417a1fcf5698a4dc63ff OK 2024/11/27 04:55:26 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/27 04:55:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test': Waiting for checks to finish 2024/11/27 04:55:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test': Waiting for transfers to finish 2024/11/27 04:55:26 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:26 INFO : There was nothing to transfer 2024/11/27 04:55:27 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/27 04:55:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:55:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:55:27 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:27 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:27 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/27 04:55:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test-include/layer2': Waiting for checks to finish 2024/11/27 04:55:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test-include/layer2': Waiting for transfers to finish 2024/11/27 04:55:27 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:27 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:27 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/27 04:55:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:55:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:55:27 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:27 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:27 DEBUG : : Excluded 2024/11/27 04:55:27 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/27 04:55:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test-ignore-file': Waiting for checks to finish 2024/11/27 04:55:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/rclone-sync-test-ignore-file': Waiting for transfers to finish 2024/11/27 04:55:27 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:27 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (10.82s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:31 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/dst" 2024/11/27 04:55:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst.bin" 2024/11/27 04:55:31 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst.bin: Auto set use_segments_container to true 2024/11/27 04:55:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst" 2024/11/27 04:55:32 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst: Auto set use_segments_container to true 2024/11/27 04:55:33 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/CompareDest" 2024/11/27 04:55:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/CompareDest.bin" 2024/11/27 04:55:33 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/CompareDest.bin: Auto set use_segments_container to true 2024/11/27 04:55:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/CompareDest" 2024/11/27 04:55:34 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/CompareDest: Auto set use_segments_container to true 2024/11/27 04:55:35 DEBUG : one: Need to transfer - File not found at Destination 2024/11/27 04:55:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:55:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:55:35 DEBUG : one: md5 = 1ded963ae9a80b02365ac3b80f841267 OK 2024/11/27 04:55:35 INFO : one: Copied (new) 2024/11/27 04:55:35 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:36 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/27 04:55:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:55:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:55:36 DEBUG : one: md5 = 770dd746e5dbbdc129f6b1d58b221e83 OK 2024/11/27 04:55:36 INFO : one: Copied (replaced existing) 2024/11/27 04:55:36 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:36 DEBUG : dst/one: md5 = 8f6e53c77a6f65ba884fca2a68715372 OK 2024/11/27 04:55:36 DEBUG : CompareDest/one: md5 = 199066aac9c27a352a73d74fa7c5410b OK 2024/11/27 04:55:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:55:37 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/27 04:55:37 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:37 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/27 04:55:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:55:37 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:37 INFO : There was nothing to transfer 2024/11/27 04:55:38 DEBUG : CompareDest/two: md5 = 03417467fe9b3f05caa0eb8b7a65eee1 OK 2024/11/27 04:55:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:38 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/27 04:55:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:55:38 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/27 04:55:38 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:38 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/27 04:55:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:55:38 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:38 INFO : There was nothing to transfer 2024/11/27 04:55:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:38 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/27 04:55:38 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/27 04:55:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:55:38 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:38 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/27 04:55:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:55:38 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:38 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2024/11/27 04:55:39 DEBUG : two: Sizes differ (src 5 vs dst 3) 2024/11/27 04:55:39 DEBUG : two: Need to transfer - File not found at Destination 2024/11/27 04:55:39 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/27 04:55:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:55:39 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:39 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/27 04:55:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:55:39 DEBUG : two: md5 = 5c1fadfaf908e18efac90d243c8e2770 OK 2024/11/27 04:55:39 INFO : two: Copied (new) 2024/11/27 04:55:39 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (9.61s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:41 DEBUG : pre-dest1/1: md5 = a3d2f2e7f7aa1ec497ae020c172ceb4e OK 2024/11/27 04:55:42 DEBUG : pre-dest2/2: md5 = 11807a4eb778d9e5b1ed6b59c75f4bcd OK 2024/11/27 04:55:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/dest" 2024/11/27 04:55:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dest.bin" 2024/11/27 04:55:42 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dest.bin: Auto set use_segments_container to true 2024/11/27 04:55:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dest" 2024/11/27 04:55:43 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dest: Auto set use_segments_container to true 2024/11/27 04:55:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/pre-dest1" 2024/11/27 04:55:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/pre-dest1.bin" 2024/11/27 04:55:44 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/pre-dest1.bin: Auto set use_segments_container to true 2024/11/27 04:55:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/pre-dest1" 2024/11/27 04:55:45 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/pre-dest1: Auto set use_segments_container to true 2024/11/27 04:55:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/pre-dest2" 2024/11/27 04:55:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/pre-dest2.bin" 2024/11/27 04:55:46 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/pre-dest2.bin: Auto set use_segments_container to true 2024/11/27 04:55:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/pre-dest2" 2024/11/27 04:55:47 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/pre-dest2: Auto set use_segments_container to true 2024/11/27 04:55:47 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:47 DEBUG : 1: Destination found in --compare-dest, skipping 2024/11/27 04:55:47 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:47 DEBUG : 2: Destination found in --compare-dest, skipping 2024/11/27 04:55:48 DEBUG : 3: Need to transfer - File not found at Destination 2024/11/27 04:55:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dest': Waiting for checks to finish 2024/11/27 04:55:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dest': Waiting for transfers to finish 2024/11/27 04:55:48 DEBUG : 3: md5 = f88fa6e43d376cda4d311d4c0051e3bc OK 2024/11/27 04:55:48 INFO : 3: Copied (new) 2024/11/27 04:55:48 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (9.52s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:55:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/dst" 2024/11/27 04:55:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst.bin" 2024/11/27 04:55:50 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst.bin: Auto set use_segments_container to true 2024/11/27 04:55:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst" 2024/11/27 04:55:51 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst: Auto set use_segments_container to true 2024/11/27 04:55:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/CopyDest" 2024/11/27 04:55:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/CopyDest.bin" 2024/11/27 04:55:52 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/CopyDest.bin: Auto set use_segments_container to true 2024/11/27 04:55:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/CopyDest" 2024/11/27 04:55:53 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/CopyDest: Auto set use_segments_container to true 2024/11/27 04:55:54 DEBUG : one: Need to transfer - File not found at Destination 2024/11/27 04:55:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:55:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:55:54 DEBUG : one: md5 = c49ad581c574ef3c94207651a9fb9985 OK 2024/11/27 04:55:54 INFO : one: Copied (new) 2024/11/27 04:55:54 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:54 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/27 04:55:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:55:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:55:55 DEBUG : one: md5 = 0a88e91cf574c01349326c9581cd958e OK 2024/11/27 04:55:55 INFO : one: Copied (replaced existing) 2024/11/27 04:55:55 DEBUG : Waiting for deletions to finish 2024/11/27 04:55:55 DEBUG : dst/one: md5 = c098460a1bf41266e70fbea8ff447e71 OK 2024/11/27 04:55:56 DEBUG : CopyDest/one: md5 = f7cea235cb18360ea5059f552be53d78 OK 2024/11/27 04:55:56 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/BackupDir" 2024/11/27 04:55:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/BackupDir.bin" 2024/11/27 04:55:56 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/BackupDir.bin: Auto set use_segments_container to true 2024/11/27 04:55:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/BackupDir" 2024/11/27 04:55:57 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/BackupDir: Auto set use_segments_container to true 2024/11/27 04:55:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:55:58 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/27 04:55:58 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:55:58 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/27 04:55:59 INFO : one: Copied (server-side copy) 2024/11/27 04:55:59 INFO : one: Deleted 2024/11/27 04:55:59 INFO : one: Copied (server-side copy) 2024/11/27 04:55:59 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/11/27 04:55:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:55:59 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:00 DEBUG : CopyDest/two: md5 = b4a8fe13f381e719da50e77367981d13 OK 2024/11/27 04:56:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:00 INFO : two: Copied (server-side copy) 2024/11/27 04:56:00 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/11/27 04:56:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:01 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:01 DEBUG : one: Unchanged skipping 2024/11/27 04:56:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:01 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:01 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:01 DEBUG : one: Unchanged skipping 2024/11/27 04:56:01 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:01 DEBUG : two: Unchanged skipping 2024/11/27 04:56:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:01 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:01 INFO : There was nothing to transfer 2024/11/27 04:56:02 DEBUG : CopyDest/three: md5 = b2c76d1e5faa906a4562e6d35b7cb79e OK 2024/11/27 04:56:02 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/11/27 04:56:02 DEBUG : three: Destination not found in --copy-dest 2024/11/27 04:56:02 DEBUG : three: Need to transfer - File not found at Destination 2024/11/27 04:56:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:03 DEBUG : two: Unchanged skipping 2024/11/27 04:56:03 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:03 DEBUG : one: Unchanged skipping 2024/11/27 04:56:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:03 DEBUG : three: md5 = d80de1100caec0fc196c255fc3a07e2b OK 2024/11/27 04:56:03 INFO : three: Copied (new) 2024/11/27 04:56:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (16.02s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:06 DEBUG : dst/one: md5 = 798e6e7daaed68fd2f870c876c4f83c7 OK 2024/11/27 04:56:06 DEBUG : dst/two: md5 = f9c9bd787c450b1cae6153aefa855572 OK 2024/11/27 04:56:07 DEBUG : dst/three.txt: md5 = 0b17eb00f609ad72e28aa70763128019 OK 2024/11/27 04:56:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst.bin" 2024/11/27 04:56:07 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst.bin: Auto set use_segments_container to true 2024/11/27 04:56:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:08 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst: Auto set use_segments_container to true 2024/11/27 04:56:08 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/backup" 2024/11/27 04:56:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/backup.bin" 2024/11/27 04:56:09 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/backup.bin: Auto set use_segments_container to true 2024/11/27 04:56:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/backup" 2024/11/27 04:56:10 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/backup: Auto set use_segments_container to true 2024/11/27 04:56:10 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/27 04:56:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:10 DEBUG : two: Unchanged skipping 2024/11/27 04:56:11 INFO : one: Copied (server-side copy) 2024/11/27 04:56:11 INFO : one: Deleted 2024/11/27 04:56:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:11 DEBUG : one: md5 = 111321ded5015a18ef8a0011c47cb75c OK 2024/11/27 04:56:11 INFO : one: Copied (new) 2024/11/27 04:56:11 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:12 INFO : three.txt: Copied (server-side copy) 2024/11/27 04:56:12 INFO : three.txt: Deleted 2024/11/27 04:56:12 INFO : three.txt: Moved into backup dir 2024/11/27 04:56:13 DEBUG : dst/three.txt: md5 = a025d9d278c16912881f74652bb102b5 OK 2024/11/27 04:56:13 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/27 04:56:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:13 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:13 DEBUG : two: Unchanged skipping 2024/11/27 04:56:14 INFO : one: Copied (server-side copy) 2024/11/27 04:56:14 INFO : one: Deleted 2024/11/27 04:56:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:14 DEBUG : one: md5 = c5aed0a3eb19568bad6dfab7d497db83 OK 2024/11/27 04:56:14 INFO : one: Copied (new) 2024/11/27 04:56:14 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:14 INFO : three.txt: Copied (server-side copy) 2024/11/27 04:56:14 INFO : three.txt: Deleted 2024/11/27 04:56:14 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (10.19s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:16 DEBUG : dst/one: md5 = fbe8c0353edc01d9687d20e942a3a7dc OK 2024/11/27 04:56:16 DEBUG : dst/two: md5 = 2e59c9684d811e95f683a6a5b6910322 OK 2024/11/27 04:56:17 DEBUG : dst/three.txt: md5 = 41e0dae9bce5049be5b1e2c593eda956 OK 2024/11/27 04:56:17 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst.bin" 2024/11/27 04:56:18 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst.bin: Auto set use_segments_container to true 2024/11/27 04:56:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:18 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst: Auto set use_segments_container to true 2024/11/27 04:56:19 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/backup" 2024/11/27 04:56:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/backup.bin" 2024/11/27 04:56:19 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/backup.bin: Auto set use_segments_container to true 2024/11/27 04:56:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/backup" 2024/11/27 04:56:20 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/backup: Auto set use_segments_container to true 2024/11/27 04:56:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/27 04:56:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:20 DEBUG : two: Unchanged skipping 2024/11/27 04:56:21 INFO : one: Copied (server-side copy) to: one.bak 2024/11/27 04:56:21 INFO : one: Deleted 2024/11/27 04:56:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:21 DEBUG : one: md5 = 9c2c50f9d6c914f46fc12538fd6d5655 OK 2024/11/27 04:56:21 INFO : one: Copied (new) 2024/11/27 04:56:21 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:22 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/27 04:56:22 INFO : three.txt: Deleted 2024/11/27 04:56:22 INFO : three.txt: Moved into backup dir 2024/11/27 04:56:23 DEBUG : dst/three.txt: md5 = d2c8987c31c5ce34c10afb1463517167 OK 2024/11/27 04:56:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:23 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/27 04:56:23 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:23 DEBUG : two: Unchanged skipping 2024/11/27 04:56:23 INFO : one: Copied (server-side copy) to: one.bak 2024/11/27 04:56:23 INFO : one: Deleted 2024/11/27 04:56:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:24 DEBUG : one: md5 = 36a762dca869b33a0e46cb0da2035f76 OK 2024/11/27 04:56:24 INFO : one: Copied (new) 2024/11/27 04:56:24 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:24 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/27 04:56:24 INFO : three.txt: Deleted 2024/11/27 04:56:24 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (9.32s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:25 DEBUG : dst/one: md5 = 2105679503a119ad3c0fc92904bf341d OK 2024/11/27 04:56:26 DEBUG : dst/two: md5 = a2da642488cbc20a52b4cab73a809ea6 OK 2024/11/27 04:56:26 DEBUG : dst/three.txt: md5 = 45aa4cbddc3f831df256111980297ef0 OK 2024/11/27 04:56:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst.bin" 2024/11/27 04:56:27 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst.bin: Auto set use_segments_container to true 2024/11/27 04:56:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:27 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst: Auto set use_segments_container to true 2024/11/27 04:56:28 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/backup" 2024/11/27 04:56:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/backup.bin" 2024/11/27 04:56:28 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/backup.bin: Auto set use_segments_container to true 2024/11/27 04:56:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/backup" 2024/11/27 04:56:29 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/backup: Auto set use_segments_container to true 2024/11/27 04:56:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/27 04:56:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:29 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:29 DEBUG : two: Unchanged skipping 2024/11/27 04:56:30 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/27 04:56:30 INFO : one: Deleted 2024/11/27 04:56:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:30 DEBUG : one: md5 = 5b568d6f8203487cecfd03d3dd43f24b OK 2024/11/27 04:56:30 INFO : one: Copied (new) 2024/11/27 04:56:30 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:31 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/27 04:56:31 INFO : three.txt: Deleted 2024/11/27 04:56:31 INFO : three.txt: Moved into backup dir 2024/11/27 04:56:31 DEBUG : dst/three.txt: md5 = fd77693ac45b72b1580d8e9f62b83d6e OK 2024/11/27 04:56:32 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/27 04:56:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:32 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:32 DEBUG : two: Unchanged skipping 2024/11/27 04:56:32 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/27 04:56:32 INFO : one: Deleted 2024/11/27 04:56:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:32 DEBUG : one: md5 = a97d074438576dbaf657394aa3ec73d4 OK 2024/11/27 04:56:32 INFO : one: Copied (new) 2024/11/27 04:56:32 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:32 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/27 04:56:32 INFO : three.txt: Deleted 2024/11/27 04:56:32 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (8.30s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:34 DEBUG : dst/one: md5 = 2815a1d70c94dbfcf7c152b0102b3f63 OK 2024/11/27 04:56:34 DEBUG : dst/two: md5 = 52a74b5bf787033ce4cf30c105ace294 OK 2024/11/27 04:56:34 DEBUG : dst/three.txt: md5 = 97a9786f7a40b632d0c366dd9ea168ae OK 2024/11/27 04:56:34 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst.bin" 2024/11/27 04:56:35 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst.bin: Auto set use_segments_container to true 2024/11/27 04:56:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:36 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst: Auto set use_segments_container to true 2024/11/27 04:56:36 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/27 04:56:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:36 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:36 DEBUG : two: Unchanged skipping 2024/11/27 04:56:37 INFO : one: Copied (server-side copy) to: one.bak 2024/11/27 04:56:37 INFO : one: Deleted 2024/11/27 04:56:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:37 DEBUG : one: md5 = dc9b2e7b8e2197c92f42a4f1cc7c4552 OK 2024/11/27 04:56:37 INFO : one: Copied (new) 2024/11/27 04:56:37 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:38 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/27 04:56:38 INFO : three.txt: Deleted 2024/11/27 04:56:38 INFO : three.txt: Moved into backup dir 2024/11/27 04:56:38 DEBUG : dst/three.txt: md5 = 5e6aed0993cbcf42153cd2af21a1db88 OK 2024/11/27 04:56:39 DEBUG : one.bak: Excluded (Path Filter) 2024/11/27 04:56:39 DEBUG : one.bak: Excluded 2024/11/27 04:56:39 DEBUG : three.txt.bak: Excluded (Path Filter) 2024/11/27 04:56:39 DEBUG : three.txt.bak: Excluded 2024/11/27 04:56:39 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/27 04:56:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for checks to finish 2024/11/27 04:56:39 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:39 DEBUG : two: Unchanged skipping 2024/11/27 04:56:39 INFO : one: Copied (server-side copy) to: one.bak 2024/11/27 04:56:39 INFO : one: Deleted 2024/11/27 04:56:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito/dst': Waiting for transfers to finish 2024/11/27 04:56:40 DEBUG : one: md5 = cfe0c90eea81fdf780f433331940f282 OK 2024/11/27 04:56:40 INFO : one: Copied (new) 2024/11/27 04:56:40 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:40 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/27 04:56:40 INFO : three.txt: Deleted 2024/11/27 04:56:40 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (7.73s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:41 DEBUG : dst/one: md5 = 4a2f32b2b9e8e771ede483aeba902022 OK 2024/11/27 04:56:42 DEBUG : dst/two: md5 = 462a1f762e07118c7b33407e2ee9f23c OK 2024/11/27 04:56:42 DEBUG : dst/three.txt: md5 = ab6d1bf8840e9b9a3947884aad0c7ad4 OK 2024/11/27 04:56:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst.bin" 2024/11/27 04:56:43 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst.bin: Auto set use_segments_container to true 2024/11/27 04:56:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:43 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst: Auto set use_segments_container to true 2024/11/27 04:56:44 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/27 04:56:44 INFO : one: Copied (server-side copy) to: one.bak 2024/11/27 04:56:44 INFO : one: Deleted 2024/11/27 04:56:44 DEBUG : one: md5 = 6ade8a3a0ca908d9e43fb847866a5cc1 OK 2024/11/27 04:56:44 INFO : one: Copied (new) 2024/11/27 04:56:44 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:44 DEBUG : two: Unchanged skipping 2024/11/27 04:56:44 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/11/27 04:56:44 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/27 04:56:45 INFO : three.txt: Deleted 2024/11/27 04:56:45 DEBUG : three.txt: md5 = 4fb34638c5f378d2d6e17d5707309220 OK 2024/11/27 04:56:45 INFO : three.txt: Copied (new) 2024/11/27 04:56:45 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/27 04:56:46 INFO : one: Copied (server-side copy) to: one.bak 2024/11/27 04:56:46 INFO : one: Deleted 2024/11/27 04:56:46 DEBUG : one: md5 = b7845d54651a0c6680e3daae55eda1e6 OK 2024/11/27 04:56:46 INFO : one: Copied (new) 2024/11/27 04:56:46 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:46 DEBUG : two: Unchanged skipping 2024/11/27 04:56:46 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/11/27 04:56:46 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/27 04:56:46 INFO : three.txt: Deleted 2024/11/27 04:56:47 DEBUG : three.txt: md5 = 2ec2b7c4ea0b7e61c69e1b2431be70bb OK 2024/11/27 04:56:47 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (6.62s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:48 DEBUG : dst/one: md5 = 7bbab278540034d019a0e53a502cf37b OK 2024/11/27 04:56:48 DEBUG : dst/two: md5 = 93eb5aa9232fcf50f8611277f42c01c5 OK 2024/11/27 04:56:48 DEBUG : dst/three.txt: md5 = b25687cd3b726e9ca6c950704ecdb8d9 OK 2024/11/27 04:56:49 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst.bin" 2024/11/27 04:56:49 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst.bin: Auto set use_segments_container to true 2024/11/27 04:56:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bozodiz0mito/dst" 2024/11/27 04:56:50 DEBUG : Swift container crypt path rclone-test-bozodiz0mito/dst: Auto set use_segments_container to true 2024/11/27 04:56:50 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/27 04:56:51 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/27 04:56:51 INFO : one: Deleted 2024/11/27 04:56:51 DEBUG : one: md5 = 9fa26dac2900b11c8f6e5b4d04f82c8f OK 2024/11/27 04:56:51 INFO : one: Copied (new) 2024/11/27 04:56:51 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:51 DEBUG : two: Unchanged skipping 2024/11/27 04:56:51 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/11/27 04:56:51 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/27 04:56:52 INFO : three.txt: Deleted 2024/11/27 04:56:52 DEBUG : three.txt: md5 = b8c616825f9d6f983ea5cd02984ba02c OK 2024/11/27 04:56:52 INFO : three.txt: Copied (new) 2024/11/27 04:56:52 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/27 04:56:53 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/27 04:56:53 INFO : one: Deleted 2024/11/27 04:56:53 DEBUG : one: md5 = 7cb50ddbd6913919578230d8093b2140 OK 2024/11/27 04:56:53 INFO : one: Copied (new) 2024/11/27 04:56:53 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:53 DEBUG : two: Unchanged skipping 2024/11/27 04:56:53 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/11/27 04:56:53 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/27 04:56:53 INFO : three.txt: Deleted 2024/11/27 04:56:54 DEBUG : three.txt: md5 = cc0cf46969895cd880a7276f03cc59df OK 2024/11/27 04:56:54 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (6.98s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:55 DEBUG : Testêé: md5 = 5ac1a2a5bcf7d2bc92f9816460123e06 OK 2024/11/27 04:56:55 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/11/27 04:56:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:56:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:56:56 DEBUG : Testêé: md5 = cc20a9de9ea204428ae294353f1a311c OK 2024/11/27 04:56:56 INFO : Testêé: Copied (replaced existing) to: Testêé 2024/11/27 04:56:56 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (1.35s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:56 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/27 04:56:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:56:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:56:57 DEBUG : existing: md5 = 073d610a769eea51799323ecdfd428f5 OK 2024/11/27 04:56:57 INFO : existing: Copied (new) 2024/11/27 04:56:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:57 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2024/11/27 04:56:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:56:57 ERROR : existing: Source and destination exist but do not match: immutable file modified 2024/11/27 04:56:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:56:57 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': not deleting files as there were IO errors 2024/11/27 04:56:57 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncImmutable (1.62s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:56:58 DEBUG : EXISTING: md5 = f17dec159aa744cdfbda82b2c5d7c7b8 OK 2024/11/27 04:56:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:56:59 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:56:59 DEBUG : existing: Unchanged skipping 2024/11/27 04:56:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:56:59 DEBUG : Waiting for deletions to finish 2024/11/27 04:56:59 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.23s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.32s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", 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-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", 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-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.49s) --- SKIP: TestMaxTransfer/Hard (0.09s) --- SKIP: TestMaxTransfer/Soft (0.31s) --- SKIP: TestMaxTransfer/Cautious (0.09s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:57:00 DEBUG : both0: md5 = 9d444da2d53c44b41fce1875180f7d0d OK 2024/11/27 04:57:01 DEBUG : only0: md5 = b59efe8e7529c0d7987c6c8ae2996ed6 OK 2024/11/27 04:57:01 DEBUG : both1: md5 = a4e43107e675e524577d561bbd4a2720 OK 2024/11/27 04:57:02 DEBUG : only1: md5 = 6bc830d898b3f3402f77d6fa3b5cc360 OK 2024/11/27 04:57:03 DEBUG : both2: md5 = c4fa56c4e3e266285a85611652bdb4c8 OK 2024/11/27 04:57:03 DEBUG : only2: md5 = 3e416e5f95c2b6755635f117332af32f OK 2024/11/27 04:57:03 DEBUG : both3: md5 = 4c0406b968bce4eca3c32f420ec17185 OK 2024/11/27 04:57:04 DEBUG : only3: md5 = 07d0a282fe800e06e05bc4d4e6be922e OK 2024/11/27 04:57:05 DEBUG : both4: md5 = bc5510df35f1f9f975ebe0ea01e242e7 OK 2024/11/27 04:57:05 DEBUG : only4: md5 = 1f06993855a03ff2a8879bb7445e56f6 OK 2024/11/27 04:57:06 DEBUG : both5: md5 = a30431a8b465c2d86e273690d05d5f7b OK 2024/11/27 04:57:07 DEBUG : only5: md5 = a298e03c4e0b5c4bb809914049fd6a14 OK 2024/11/27 04:57:07 DEBUG : both6: md5 = b44653d5cfdbc00f3a2177f0597d7cd4 OK 2024/11/27 04:57:07 DEBUG : only6: md5 = 7354249841df10f8fae4cf320f27e2eb OK 2024/11/27 04:57:08 DEBUG : both7: md5 = 9b883863b54d6ea495b684418c5fc05d OK 2024/11/27 04:57:08 DEBUG : only7: md5 = e266f41e432dc7c8a93c3a6e6a144fa2 OK 2024/11/27 04:57:09 DEBUG : both8: md5 = 32844fbe25ec694ca2cca61c34fb2ccd OK 2024/11/27 04:57:09 DEBUG : only8: md5 = 95e95b623fc81a21dd91c96f3a71445d OK 2024/11/27 04:57:09 DEBUG : both9: md5 = e6cec09cd1dbae754402186d1448c686 OK 2024/11/27 04:57:09 DEBUG : only9: md5 = 4c34b37be3fe1ec47ae3c89495a6a938 OK 2024/11/27 04:57:10 DEBUG : both10: md5 = a224eb3c0864e498f5f86f1c21bfe923 OK 2024/11/27 04:57:11 DEBUG : only10: md5 = a01a76b3b277269416c5ecc87b031e8a OK 2024/11/27 04:57:11 DEBUG : both11: md5 = ff5239d839f2e3c0708bbfc983f758d6 OK 2024/11/27 04:57:12 DEBUG : only11: md5 = 3ea736d69c29136159a392aa06783a5e OK 2024/11/27 04:57:12 DEBUG : both12: md5 = 4b54c3b82bc3a9d73f4f6bc14aa9d0d7 OK 2024/11/27 04:57:13 DEBUG : only12: md5 = e6b80882d7a876191829c1f82210f45c OK 2024/11/27 04:57:13 DEBUG : both13: md5 = 81dc82a6d9ffd45edad23b652329d8b3 OK 2024/11/27 04:57:14 DEBUG : only13: md5 = c36e63a9a3b3606768e69b33bc27a69c OK 2024/11/27 04:57:14 DEBUG : both14: md5 = 51c20d6dad70c9bc275c14df2684b616 OK 2024/11/27 04:57:17 DEBUG : only14: md5 = 85f360a83a96140d396b9e64a66c7337 OK 2024/11/27 04:57:18 DEBUG : both15: md5 = 96c04307351376082ecfd7e5bdd759e7 OK 2024/11/27 04:57:18 DEBUG : only15: md5 = fd5dabf9db3792256f66a5909b391ec0 OK 2024/11/27 04:57:19 DEBUG : both16: md5 = 2b2684f481f25849cb8ae8bfcbabd4f1 OK 2024/11/27 04:57:19 DEBUG : only16: md5 = 836b7d33efe6923dd71f0c71ee2f6518 OK 2024/11/27 04:57:19 DEBUG : both17: md5 = 178ea075526ffa222980d7bca40d79e5 OK 2024/11/27 04:57:20 DEBUG : only17: md5 = bdb10f1e7c6252db433099542eae6e52 OK 2024/11/27 04:57:21 DEBUG : both18: md5 = ef8c923fc77ee7f1aad2185ea126f900 OK 2024/11/27 04:57:21 DEBUG : only18: md5 = 8efeae7d638bae84548a09328033c489 OK 2024/11/27 04:57:21 DEBUG : both19: md5 = e89338923b29577e4cd0d7bf16dfbf8b OK 2024/11/27 04:57:22 DEBUG : only19: md5 = 258557dee43442e48296285b08e22994 OK 2024/11/27 04:57:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:57:24 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both0: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both1: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both10: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both11: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both14: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both12: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both13: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both15: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both16: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both17: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both18: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both19: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both2: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both3: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both4: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both5: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both6: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both7: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both8: Unchanged skipping 2024/11/27 04:57:24 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:24 DEBUG : both9: Unchanged skipping 2024/11/27 04:57:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:57:24 DEBUG : Waiting for deletions to finish 2024/11/27 04:57:24 INFO : only3: Deleted 2024/11/27 04:57:24 INFO : only8: Deleted 2024/11/27 04:57:24 INFO : only5: Deleted 2024/11/27 04:57:24 INFO : only16: Deleted 2024/11/27 04:57:24 INFO : only19: Deleted 2024/11/27 04:57:24 INFO : only13: Deleted 2024/11/27 04:57:24 INFO : only6: Deleted 2024/11/27 04:57:24 INFO : only17: Deleted 2024/11/27 04:57:24 INFO : only11: Deleted 2024/11/27 04:57:24 INFO : only18: Deleted 2024/11/27 04:57:24 INFO : only12: Deleted 2024/11/27 04:57:25 INFO : only4: Deleted 2024/11/27 04:57:25 INFO : only10: Deleted 2024/11/27 04:57:25 INFO : only14: Deleted 2024/11/27 04:57:25 INFO : only1: Deleted 2024/11/27 04:57:25 INFO : only15: Deleted 2024/11/27 04:57:25 INFO : only7: Deleted 2024/11/27 04:57:25 INFO : only2: Deleted 2024/11/27 04:57:25 INFO : only0: Deleted 2024/11/27 04:57:25 INFO : only9: Deleted 2024/11/27 04:57:25 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (30.44s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:57:31 DEBUG : both0: md5 = 4e571c2628e652da02bfda2510e51748 OK 2024/11/27 04:57:31 DEBUG : only0: md5 = 20296976e796cd9cd87d40a6e61bd7c6 OK 2024/11/27 04:57:31 DEBUG : both1: md5 = f65b4300a26adc8600015425bfc1f51e OK 2024/11/27 04:57:31 DEBUG : only1: md5 = d94f9bfe8f2a36f1299909267c7f34a3 OK 2024/11/27 04:57:31 DEBUG : both2: md5 = 4ff2f6c185af3c132bc41ce9e1174c92 OK 2024/11/27 04:57:31 DEBUG : only2: md5 = 3815e2b634d55bf4ffd54746f66c5381 OK 2024/11/27 04:57:32 DEBUG : both3: md5 = efc7235550305043095a7f13290f48b0 OK 2024/11/27 04:57:32 DEBUG : only3: md5 = b06e8e009900bf1c14a5e2bfbdeca2bd OK 2024/11/27 04:57:32 DEBUG : both4: md5 = 29f8d95e1b4f278d59f0b663a1d7bbb5 OK 2024/11/27 04:57:32 DEBUG : only4: md5 = 3a64f58923c5a351a0c3a9b6e411d399 OK 2024/11/27 04:57:32 DEBUG : both5: md5 = 0b6646f48d45319b3926a0dda566010f OK 2024/11/27 04:57:33 DEBUG : only5: md5 = f75f5cc0b186c62c5bc1511a098d6078 OK 2024/11/27 04:57:33 DEBUG : both6: md5 = 1b45603aff290b65bb8df36d9b145ef3 OK 2024/11/27 04:57:33 DEBUG : only6: md5 = d79d08320409858eaf01c7e3f7495584 OK 2024/11/27 04:57:33 DEBUG : both7: md5 = 8e787152e8d660a897e2a9b4e74e098c OK 2024/11/27 04:57:33 DEBUG : only7: md5 = d9e70e7f430cb0954cbb9d76a441c0ea OK 2024/11/27 04:57:33 DEBUG : both8: md5 = d55fd1a656f5b36725c7ea824f0ce023 OK 2024/11/27 04:57:34 DEBUG : only8: md5 = e89a319fe6f500c99c8c1b9d1b474c68 OK 2024/11/27 04:57:34 DEBUG : both9: md5 = 78e467dc7c945ad23c5abc20d795e211 OK 2024/11/27 04:57:34 DEBUG : only9: md5 = ba3f626e5b7cb0200eaaca48fda4ec26 OK 2024/11/27 04:57:34 DEBUG : both10: md5 = 70cee860ec379db86ec6e066ca5163d5 OK 2024/11/27 04:57:35 DEBUG : only10: md5 = 0af876847b61bdf783c0991b74860c03 OK 2024/11/27 04:57:35 DEBUG : both11: md5 = 728ded6710b4d9bdf4d6a5ce0b61da1a OK 2024/11/27 04:57:35 DEBUG : only11: md5 = 912cade8c2029c9ac538358bb634a18d OK 2024/11/27 04:57:35 DEBUG : both12: md5 = 258b02261234932115f489d7769281b1 OK 2024/11/27 04:57:35 DEBUG : only12: md5 = 70c9a731d515895e9e20ab63f1ef399c OK 2024/11/27 04:57:36 DEBUG : both13: md5 = 3f4c43684458c5b68c48e16c8f1f7e97 OK 2024/11/27 04:57:36 DEBUG : only13: md5 = 7f18c3df70a27faec76ad0f99edda5c3 OK 2024/11/27 04:57:36 DEBUG : both14: md5 = ea0458b5a1459d9b4dcbbd832960e9f6 OK 2024/11/27 04:57:37 DEBUG : only14: md5 = 1b3c0bde35b514cefb282ede19d32cd8 OK 2024/11/27 04:57:37 DEBUG : both15: md5 = 2f270a4bbe1f6928a36cef1caf2d68bf OK 2024/11/27 04:57:37 DEBUG : only15: md5 = 893578663a1438b2298f86bbbd7947e4 OK 2024/11/27 04:57:37 DEBUG : both16: md5 = a5d4d1b82cbe9dca55815de51d40c4ad OK 2024/11/27 04:57:38 DEBUG : only16: md5 = e9dbcaffd2a6bc22db6dee166b92f1fe OK 2024/11/27 04:57:38 DEBUG : both17: md5 = 9a44b8bd2cd2a6a6d42aa686e941b7f8 OK 2024/11/27 04:57:38 DEBUG : only17: md5 = 41239577086a1558005fbbe4859bbf3a OK 2024/11/27 04:57:38 DEBUG : both18: md5 = 0818d0b59b2378e0c8b55f127acf1d71 OK 2024/11/27 04:57:38 DEBUG : only18: md5 = eccbc4df639ba47f8ce2deb452eea552 OK 2024/11/27 04:57:39 DEBUG : both19: md5 = 62c1a37f1a625c1da4fa6a55bfec18e8 OK 2024/11/27 04:57:39 DEBUG : only19: md5 = d56f68c1ccb1539a2dd428814842a29b OK 2024/11/27 04:57:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for checks to finish 2024/11/27 04:57:41 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both10: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both11: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both0: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both1: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both12: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both13: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both14: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both15: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both16: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both17: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both18: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both19: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both2: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both3: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both4: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both5: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both6: Unchanged skipping 2024/11/27 04:57:41 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : both7: Unchanged skipping 2024/11/27 04:57:41 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2024/11/27 04:57:41 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both8: Unchanged skipping 2024/11/27 04:57:41 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/27 04:57:41 DEBUG : both9: Unchanged skipping 2024/11/27 04:57:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Waiting for transfers to finish 2024/11/27 04:57:41 DEBUG : only0: md5 = bd719b0d3250a6a95d4c540eb3130228 OK 2024/11/27 04:57:41 INFO : only0: Copied (replaced existing) 2024/11/27 04:57:41 DEBUG : only11: md5 = 743fa631890500c469d7225af24a3c25 OK 2024/11/27 04:57:41 INFO : only11: Copied (replaced existing) 2024/11/27 04:57:41 DEBUG : only10: md5 = 142ca16a124760ecc558c049358771cc OK 2024/11/27 04:57:41 INFO : only10: Copied (replaced existing) 2024/11/27 04:57:41 DEBUG : only1: md5 = 3a041acd9535153a245c308bb8e5dfb3 OK 2024/11/27 04:57:41 INFO : only1: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only13: md5 = 0e55d8040de14ca3f2bdd6722e73d9ac OK 2024/11/27 04:57:42 INFO : only13: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only12: md5 = 30be583e24d1fa8f71e1acd712066d62 OK 2024/11/27 04:57:42 INFO : only12: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only14: md5 = cea6f4c34f056635e0ff7a3189f3c6f8 OK 2024/11/27 04:57:42 INFO : only14: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only16: md5 = 33a3568ce080fe3fe12f9c06c3b9d18e OK 2024/11/27 04:57:42 INFO : only16: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only17: md5 = de60b2f5afd8dfa29fe5e8ef925c4dff OK 2024/11/27 04:57:42 INFO : only17: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only18: md5 = ade1371fa0925599f6068727300dc8b3 OK 2024/11/27 04:57:42 INFO : only18: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only2: md5 = b1c1521a040f03398a0d8756a46751f8 OK 2024/11/27 04:57:42 INFO : only2: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only15: md5 = a443ddf47717c95cb9e9ee9d4a30ac1b OK 2024/11/27 04:57:42 INFO : only15: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only19: md5 = d97faf41062e6adfacaf0f5a188c177b OK 2024/11/27 04:57:42 INFO : only19: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only3: md5 = 37514a7a54801cf67fdb327aabd14b2a OK 2024/11/27 04:57:42 INFO : only3: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only7: md5 = d40bcf7a457ac2be270a921cb32b4908 OK 2024/11/27 04:57:42 INFO : only7: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only4: md5 = 638e1297c32e9873972eae06639a5a91 OK 2024/11/27 04:57:42 INFO : only4: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only8: md5 = cf0ea4b6981d879b9c7e822dfe62130f OK 2024/11/27 04:57:42 INFO : only8: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only5: md5 = 862c82cdbc55151c8548bc7d3e833434 OK 2024/11/27 04:57:42 INFO : only5: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only6: md5 = e7c6881b58cef1e09d10aa7d09efe6f1 OK 2024/11/27 04:57:42 INFO : only6: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : only9: md5 = 1d254bd76bfb6ae41acc707ec7bd7f7e OK 2024/11/27 04:57:42 INFO : only9: Copied (replaced existing) 2024/11/27 04:57:42 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (21.47s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:57:52 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/27 04:57:52 DEBUG : sub dir: Making directory 2024/11/27 04:57:52 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-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (2.47s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" 2024/11/27 04:57:54 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/27 04:57:54 DEBUG : sub dir: Making directory 2024/11/27 04:57:54 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-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito'", Local "Local file system at /tmp/rclone448413988", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (1.88s) PASS 2024/11/27 04:57:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bozodiz0mito': Purge remote 2024/11/27 04:57:56 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 4m53.07283314s (try 1/5)