"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2025/03/31 04:16:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare" 2025/03/31 04:16:42 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/31 04:16:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare.bin" 2025/03/31 04:16:43 DEBUG : Swift container crypt path rclone-test-kirukuh9lare.bin: Auto set use_segments_container to true 2025/03/31 04:16:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare" 2025/03/31 04:16:49 DEBUG : Swift container crypt path rclone-test-kirukuh9lare: Auto set use_segments_container to true 2025/03/31 04:16:54 DEBUG : Creating backend with remote "/tmp/rclone2240301564" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.04s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:16:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:16:54 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/03/31 04:16:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:16:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.59s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:16:55 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/31 04:16:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:16:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:16:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:16:55 DEBUG : sub dir/hello world: md5 = bdf5129850faa57b861409cb10db70bc OK 2025/03/31 04:16:55 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:16:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (1.26s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.10s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.10s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:16:56 DEBUG : Creating backend with remote "/non-existing" 2025/03/31 04:16:56 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/03/31 04:16:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:16:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.35s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:02 DEBUG : sub dir/hello world: md5 = b79b274202619fa39dbda9396bf5d655 OK 2025/03/31 04:17:02 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyNoTraverse (5.91s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:02 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Running all checks before starting transfers 2025/03/31 04:17:02 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:02 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Checks finished, now starting transfers 2025/03/31 04:17:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:02 DEBUG : sub dir/hello world: md5 = 84ee9840a6f910123cc3a8790c60cd8a OK 2025/03/31 04:17:02 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyCheckFirst (1.16s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:03 ERROR : Ignoring --no-traverse with sync 2025/03/31 04:17:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:04 DEBUG : sub dir/hello world: md5 = f362dc54b9c194019645acb670d44637 OK 2025/03/31 04:17:04 INFO : sub dir/hello world: Copied (new) 2025/03/31 04:17:04 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncNoTraverse (1.10s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:05 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/03/31 04:17:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:05 DEBUG : hello world2: md5 = 2c56168606012adc93f81d767cfb840b OK 2025/03/31 04:17:05 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyWithDepth (1.16s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:06 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:17:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:06 DEBUG : potato2: md5 = 75f3d92570edab1a692d02a1cdd9ed70 OK 2025/03/31 04:17:06 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (1.51s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:12 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:17:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:12 DEBUG : potato2: md5 = 5430cc540615930b76ab91e59df21b23 OK 2025/03/31 04:17:12 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (6.00s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:13 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/03/31 04:17:13 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/31 04:17:13 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/03/31 04:17:13 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/31 04:17:13 INFO : sub dir: Making directory 2025/03/31 04:17:13 INFO : sub dir2: Making directory 2025/03/31 04:17:13 INFO : sub dir2/sub sub dir2: Making directory 2025/03/31 04:17:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:13 DEBUG : sub dir/hello world: md5 = c71d8c58b6178b6f779f3d009dbef54f OK 2025/03/31 04:17:13 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2025/03/31 04:17:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (1.22s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:14 INFO : sub dir2: Making directory 2025/03/31 04:17:14 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/03/31 04:17:14 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/31 04:17:14 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:15 DEBUG : sub dir/hello world: md5 = e175b64045ca51c285d0137e0ac5d0b7 OK 2025/03/31 04:17:15 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (0.75s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:15 DEBUG : sub dir2: Making directory with metadata 2025/03/31 04:17:15 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/31 04:17:15 INFO : sub dir: Making directory 2025/03/31 04:17:15 INFO : sub dir2: Making directory 2025/03/31 04:17:15 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:15 DEBUG : sub dir/hello world: md5 = 3f2690be44e8dd0fe2ac0f3e40a71ad5 OK 2025/03/31 04:17:15 INFO : sub dir/hello world: Copied (new) 2025/03/31 04:17:15 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/03/31 04:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/03/31 04:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.06s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.19s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:16 INFO : sub dir2: Making directory 2025/03/31 04:17:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:17 DEBUG : sub dir/hello world: md5 = a969971014a525125fb30c2a3125b31d OK 2025/03/31 04:17:17 INFO : sub dir/hello world: Copied (new) 2025/03/31 04:17:17 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (0.82s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:17 DEBUG : sub dir2: Making directory with metadata 2025/03/31 04:17:17 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/31 04:17:17 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/31 04:17:17 INFO : sub dir: Making directory 2025/03/31 04:17:17 INFO : sub dir2: Making directory 2025/03/31 04:17:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:17 DEBUG : sub dir/hello world: md5 = 16de267f09c9fecf1aee094684b42abe OK 2025/03/31 04:17:17 INFO : sub dir/hello world: Copied (new) 2025/03/31 04:17:17 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/03/31 04:17:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.13s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.10s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:18 INFO : sub dir2: Making directory 2025/03/31 04:17:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:17:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:17:19 DEBUG : sub dir/hello world: md5 = 3b135969fbd7bf9b363a854ca25af1bb OK 2025/03/31 04:17:19 INFO : sub dir/hello world: Copied (new) 2025/03/31 04:17:19 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (0.83s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:19 DEBUG : sub dir/hello world: md5 = b66b5b245afecd19fe1f45fefc0c0d98 OK 2025/03/31 04:17:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xeterid9kexu" 2025/03/31 04:17:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xeterid9kexu.bin" 2025/03/31 04:17:20 DEBUG : Swift container crypt path rclone-test-xeterid9kexu.bin: Auto set use_segments_container to true 2025/03/31 04:17:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xeterid9kexu" 2025/03/31 04:17:26 DEBUG : Swift container crypt path rclone-test-xeterid9kexu: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare' -> Encrypted drive 'TestCryptSwift:rclone-test-xeterid9kexu' 2025/03/31 04:17:37 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:17:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xeterid9kexu': Waiting for checks to finish 2025/03/31 04:17:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xeterid9kexu': Waiting for transfers to finish 2025/03/31 04:17:52 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:17:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xeterid9kexu': Purge remote 2025/03/31 04:17:57 DEBUG : Waiting for deletions to finish 2025/03/31 04:18:03 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (44.04s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:18:04 DEBUG : sub dir/hello world: md5 = d87c7f15744a581594e25b6315a111f2 OK 2025/03/31 04:18:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:18:04 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/31 04:18:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:18:04 DEBUG : sub dir/hello world: md5 = 9773e00dbd183fdd3998cb26d72a8366 OK 2025/03/31 04:18:04 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyOverSelf (1.58s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:18:05 DEBUG : sub dir/hello world: md5 = 612242d7d33084d2ed2c7982eb5c5869 OK 2025/03/31 04:18:05 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qurafav6qufa" 2025/03/31 04:18:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qurafav6qufa.bin" 2025/03/31 04:18:06 DEBUG : Swift container crypt path rclone-test-qurafav6qufa.bin: Auto set use_segments_container to true 2025/03/31 04:18:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qurafav6qufa" 2025/03/31 04:18:12 DEBUG : Swift container crypt path rclone-test-qurafav6qufa: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare' -> Encrypted drive 'TestCryptSwift:rclone-test-qurafav6qufa' 2025/03/31 04:18:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:18:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qurafav6qufa': Waiting for checks to finish 2025/03/31 04:18:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qurafav6qufa': Waiting for transfers to finish 2025/03/31 04:18:33 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:18:38 DEBUG : sub dir/hello world: md5 = 58b91c8eff581a3987c21b9889de7b05 OK 2025/03/31 04:18:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qurafav6qufa': Waiting for checks to finish 2025/03/31 04:18:39 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/31 04:18:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qurafav6qufa': Waiting for transfers to finish 2025/03/31 04:18:54 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:18:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qurafav6qufa': Purge remote 2025/03/31 04:18:59 DEBUG : Waiting for deletions to finish 2025/03/31 04:19:09 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (65.15s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:19:10 DEBUG : sub dir/hello world: md5 = af6f3e14f12870e2cd832668dadf6390 OK 2025/03/31 04:19:10 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/31 04:19:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:19:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:19:11 DEBUG : sub dir/hello world: md5 = 7272ef004e09c0befec61527630ca847 OK 2025/03/31 04:19:11 INFO : sub dir/hello world: Copied (replaced existing) 2025/03/31 04:19:11 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestMoveOverSelf (1.31s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:19:11 DEBUG : sub dir/hello world: md5 = 4621cb28811549bace4fbb4fdf84d0a3 OK 2025/03/31 04:19:12 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zikuqun5gocu" 2025/03/31 04:19:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zikuqun5gocu.bin" 2025/03/31 04:19:12 DEBUG : Swift container crypt path rclone-test-zikuqun5gocu.bin: Auto set use_segments_container to true 2025/03/31 04:19:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zikuqun5gocu" 2025/03/31 04:19:18 DEBUG : Swift container crypt path rclone-test-zikuqun5gocu: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare' -> Encrypted drive 'TestCryptSwift:rclone-test-zikuqun5gocu' 2025/03/31 04:19:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:19:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zikuqun5gocu': Waiting for checks to finish 2025/03/31 04:19:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zikuqun5gocu': Waiting for transfers to finish 2025/03/31 04:19:35 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:19:35 DEBUG : sub dir/hello world: md5 = 246ba041ddf27211a8ff77eab6cb561b OK 2025/03/31 04:19:36 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/31 04:19:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zikuqun5gocu': Waiting for checks to finish 2025/03/31 04:19:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zikuqun5gocu': Waiting for transfers to finish 2025/03/31 04:19:46 INFO : sub dir/hello world: Copied (server-side copy) 2025/03/31 04:19:46 INFO : sub dir/hello world: Deleted 2025/03/31 04:19:52 DEBUG : sub dir/hello world: md5 = d5f6f52b61f0c1025eedbe9ec817f106 OK 2025/03/31 04:19:52 DEBUG : testing file moves 2025/03/31 04:19:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zikuqun5gocu': Waiting for checks to finish 2025/03/31 04:19:52 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/03/31 04:19:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zikuqun5gocu': Waiting for transfers to finish 2025/03/31 04:20:02 INFO : sub dir/hello world: Copied (server-side copy) 2025/03/31 04:20:02 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:20:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zikuqun5gocu': Purge remote 2025/03/31 04:20:03 DEBUG : Waiting for deletions to finish 2025/03/31 04:20:08 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (57.34s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:20:09 DEBUG : sub dir/hello world: md5 = 129fc9eaeebe7a5c68357878bb1a7440 OK 2025/03/31 04:20:09 ERROR : : error listing: directory not found 2025/03/31 04:20:09 INFO : Local file system at /tmp/rclone2240301564: Making directory 2025/03/31 04:20:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:20:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyAfterDelete (1.64s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:20:10 DEBUG : sub dir/hello world: md5 = 0c52e36dcc33215251bb1b865b57fee2 OK 2025/03/31 04:20:11 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:20:11 DEBUG : Local file system at /tmp/rclone2240301564: Waiting for checks to finish 2025/03/31 04:20:11 DEBUG : Local file system at /tmp/rclone2240301564: Waiting for transfers to finish 2025/03/31 04:20:11 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/03/31 04:20:11 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyRedownload (1.47s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:20:12 DEBUG : check sum: Need to transfer - File not found at Destination 2025/03/31 04:20:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:20:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:20:17 DEBUG : check sum: md5 = 6457ea52c6c0e4ad4d58388ab459abd2 OK 2025/03/31 04:20:17 INFO : check sum: Copied (new) 2025/03/31 04:20:17 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:20:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:20:22 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/03/31 04:20:22 DEBUG : check sum: Size of src and dst objects identical 2025/03/31 04:20:27 DEBUG : check sum: Unchanged skipping 2025/03/31 04:20:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:20:27 DEBUG : Waiting for deletions to finish 2025/03/31 04:20:27 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (21.39s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:20:33 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/03/31 04:20:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:20:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:20:39 DEBUG : sizeonly: md5 = 945c58649a6bbebe8ca028444900d48b OK 2025/03/31 04:20:39 INFO : sizeonly: Copied (new) 2025/03/31 04:20:39 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:20:39 DEBUG : sizeonly: Sizes identical 2025/03/31 04:20:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:20:39 DEBUG : sizeonly: Unchanged skipping 2025/03/31 04:20:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:20:39 DEBUG : Waiting for deletions to finish 2025/03/31 04:20:39 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncSizeOnly (12.13s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:20:45 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/03/31 04:20:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:20:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:20:51 DEBUG : ignore-size: md5 = 95bb8a69b701eea53f1a9a093e80d51e OK 2025/03/31 04:20:51 INFO : ignore-size: Copied (new) 2025/03/31 04:20:51 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:20:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:20:51 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:20:51 DEBUG : ignore-size: Unchanged skipping 2025/03/31 04:20:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:20:51 DEBUG : Waiting for deletions to finish 2025/03/31 04:20:51 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (21.53s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:21:12 DEBUG : existing: md5 = d2e332373c175436909593111766994e OK 2025/03/31 04:21:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:21:22 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:21:22 DEBUG : existing: Unchanged skipping 2025/03/31 04:21:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:21:22 DEBUG : Waiting for deletions to finish 2025/03/31 04:21:22 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:21:23 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/03/31 04:21:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:21:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:21:28 DEBUG : existing: md5 = dddd68ffe63cf6fb1463354f747c1900 OK 2025/03/31 04:21:28 INFO : existing: Copied (replaced existing) 2025/03/31 04:21:28 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (31.86s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:21:39 DEBUG : existing: Need to transfer - File not found at Destination 2025/03/31 04:21:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:21:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:21:44 DEBUG : existing: md5 = d53ee648870070bb620073b31d386fd7 OK 2025/03/31 04:21:44 INFO : existing: Copied (new) 2025/03/31 04:21:44 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:21:44 DEBUG : existing: Destination exists, skipping 2025/03/31 04:21:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:21:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:21:44 DEBUG : Waiting for deletions to finish 2025/03/31 04:21:44 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (21.28s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:22:01 DEBUG : b/potato: md5 = 7f68335c5a714bf14705bdb3ab789f79 OK 2025/03/31 04:22:06 DEBUG : c/non empty space: md5 = f4f759d1e644e78dd38779956c070943 OK 2025/03/31 04:22:06 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/03/31 04:22:07 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/03/31 04:22:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:22:07 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:22:07 DEBUG : c/non empty space: Unchanged skipping 2025/03/31 04:22:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:22:12 DEBUG : a/potato2: md5 = ed9a25100a245b9eee4a14aba52022fb OK 2025/03/31 04:22:12 INFO : a/potato2: Copied (new) 2025/03/31 04:22:12 DEBUG : Waiting for deletions to finish 2025/03/31 04:22:12 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (23.10s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:22:29 DEBUG : empty space: md5 = a5dabe611c29c2fcfa781ca782c673b2 OK 2025/03/31 04:22:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:22:34 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/03/31 04:22:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:22:34 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/03/31 04:22:34 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:22:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:22:44 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/03/31 04:22:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:22:50 DEBUG : empty space: md5 = f2def79279627da8bb6725639a49670b OK 2025/03/31 04:22:50 INFO : empty space: Copied (replaced existing) 2025/03/31 04:22:50 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (42.74s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:1016: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.10s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:23:11 DEBUG : foo: md5 = cfbc74801b2936615d85aaafeb7fd8c2 OK 2025/03/31 04:23:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:23:17 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/03/31 04:23:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:23:22 DEBUG : foo: md5 = fa390c705e9ceaa2c7a249eeafea728a OK 2025/03/31 04:23:22 INFO : foo: Copied (replaced existing) 2025/03/31 04:23:22 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (21.56s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:23:33 DEBUG : empty space: md5 = ba1e25cbef7db6b97e703a7ce927bd94 OK 2025/03/31 04:23:33 DEBUG : potato: Need to transfer - File not found at Destination 2025/03/31 04:23:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:23:33 DEBUG : potato: md5 = 2afa6de6ca93858a2ee0ab7b8f414f98 OK 2025/03/31 04:23:33 INFO : potato: Copied (new) 2025/03/31 04:23:38 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:23:38 DEBUG : empty space: Unchanged skipping 2025/03/31 04:23:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:23:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (21.48s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:23:49 DEBUG : potato: md5 = 8f3c31bbb04a5a2f70384cb4c9fd9273 OK 2025/03/31 04:23:49 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/03/31 04:23:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:23:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:23:50 DEBUG : potato: md5 = 72e0d07f9667971f021d06bf3ce192b9 OK 2025/03/31 04:23:50 INFO : potato: Copied (replaced existing) 2025/03/31 04:23:50 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (1.48s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:23:51 DEBUG : potato: md5 = a53042116b66b825c77d7ddda222a715 OK 2025/03/31 04:23:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:23:51 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2025/03/31 04:23:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:23:51 DEBUG : potato: md5 = 06b919195540bb14811304cc1c45660f OK 2025/03/31 04:23:51 INFO : potato: Copied (replaced existing) 2025/03/31 04:23:51 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (1.50s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:23:52 DEBUG : potato: md5 = 0b1976930c7eed8bad6eee8b07345ec2 OK 2025/03/31 04:23:57 DEBUG : empty space: md5 = 0a68595c0a690368f3fa1dabe08b291a OK 2025/03/31 04:23:58 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:23:58 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/03/31 04:23:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:24:03 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:24:03 DEBUG : empty space: Unchanged skipping 2025/03/31 04:24:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:24:03 DEBUG : Waiting for deletions to finish 2025/03/31 04:24:03 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (26.63s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:24:19 DEBUG : potato: md5 = aca7327908bccd42885c451a491b47b1 OK 2025/03/31 04:24:24 DEBUG : empty space: md5 = 5b1d145d447f5f2a3f5bd407a5c40557 OK 2025/03/31 04:24:24 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:24:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:24:25 DEBUG : potato2: md5 = 8e92c5d58df816f3cb33f5cdcef6fcd8 OK 2025/03/31 04:24:25 INFO : potato2: Copied (new) 2025/03/31 04:24:30 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:24:30 DEBUG : empty space: Unchanged skipping 2025/03/31 04:24:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:24:30 DEBUG : Waiting for deletions to finish 2025/03/31 04:24:30 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (22.26s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:24:41 DEBUG : b/potato: md5 = 49b5c4c1130b24f049ab70c8072e8a15 OK 2025/03/31 04:24:46 DEBUG : c/non empty space: md5 = f7e5b029f2253fb5e8a394beb2224b2c OK 2025/03/31 04:24:46 INFO : d: Making directory 2025/03/31 04:24:46 INFO : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2025/03/31 04:24:52 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/03/31 04:24:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:24:57 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:24:57 DEBUG : c/non empty space: Unchanged skipping 2025/03/31 04:24:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:24:57 DEBUG : a/potato2: md5 = 893eebb1726a26e3027e6b08c80ebacf OK 2025/03/31 04:24:57 INFO : a/potato2: Copied (new) 2025/03/31 04:24:57 DEBUG : Waiting for deletions to finish 2025/03/31 04:24:57 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (42.51s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:25:24 DEBUG : b/potato: md5 = f8c7acc775e60e3811255de0f3ac39d4 OK 2025/03/31 04:25:29 DEBUG : c/non empty space: md5 = 1524b5045567578f7e6fc0805ecbc601 OK 2025/03/31 04:25:29 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/03/31 04:25:29 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/03/31 04:25:29 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:25:29 DEBUG : c/non empty space: Unchanged skipping 2025/03/31 04:25:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:25:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:25:34 DEBUG : a/potato2: md5 = ce45a0558e1ed319752b77f01e47ae55 OK 2025/03/31 04:25:34 INFO : a/potato2: Copied (new) 2025/03/31 04:25:34 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': not deleting files as there were IO errors 2025/03/31 04:25:35 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (37.46s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:26:01 DEBUG : potato: md5 = d56a06fb9c99ebb5b791e10e97e7397e OK 2025/03/31 04:26:07 DEBUG : empty space: md5 = 0314a12e2a4e84988c58ebec4d763f69 OK 2025/03/31 04:26:08 DEBUG : Waiting for deletions to finish 2025/03/31 04:26:08 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:26:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:26:08 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:26:08 DEBUG : empty space: Unchanged skipping 2025/03/31 04:26:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:26:08 DEBUG : potato2: md5 = 535f990015b79a0c678634eb6ce94ebd OK 2025/03/31 04:26:08 INFO : potato2: Copied (new) 2025/03/31 04:26:08 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (18.49s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:26:19 DEBUG : potato: md5 = c297be4e2ab69f0d106cd6d20a3093b0 OK 2025/03/31 04:26:26 DEBUG : empty space: md5 = fa5660739a03998e9f08f39c6bc72940 OK 2025/03/31 04:26:26 DEBUG : Waiting for deletions to finish 2025/03/31 04:26:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:26:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:26:26 INFO : potato: Deleted 2025/03/31 04:26:26 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:26:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:26:26 DEBUG : potato2: md5 = 0f27034ea65c43f1aaa60426ec2f8f0c OK 2025/03/31 04:26:26 INFO : potato2: Copied (new) 2025/03/31 04:26:31 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:26:31 DEBUG : empty space: Unchanged skipping 2025/03/31 04:26:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (18.19s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:26:38 DEBUG : potato: md5 = d4ea7d154fccad691a6f51cb4455293e OK 2025/03/31 04:26:38 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:26:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:26:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:26:38 DEBUG : potato2: md5 = 4f245f92fc95eff747ed61add256c356 OK 2025/03/31 04:26:38 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (1.99s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:26:40 DEBUG : potato2: md5 = f501ae3e403e436cc74d6cac009b2a7a OK 2025/03/31 04:26:45 DEBUG : empty space: md5 = 8bdf723b8f946cdbf846bcdbc1f36219 OK 2025/03/31 04:26:45 DEBUG : enormous: Excluded (Size Filter) 2025/03/31 04:26:45 DEBUG : enormous: Excluded 2025/03/31 04:26:45 DEBUG : potato2: Excluded (Size Filter) 2025/03/31 04:26:45 DEBUG : potato2: Excluded 2025/03/31 04:26:45 DEBUG : potato2: Excluded (Size Filter) 2025/03/31 04:26:45 DEBUG : potato2: Excluded 2025/03/31 04:26:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:26:45 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:26:45 DEBUG : empty space: Unchanged skipping 2025/03/31 04:26:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:26:45 DEBUG : Waiting for deletions to finish 2025/03/31 04:26:45 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:26:46 DEBUG : enormous: Excluded (Size Filter) 2025/03/31 04:26:46 DEBUG : enormous: Excluded 2025/03/31 04:26:46 DEBUG : potato2: Excluded (Size Filter) 2025/03/31 04:26:46 DEBUG : potato2: Excluded 2025/03/31 04:26:46 DEBUG : potato2: Excluded (Size Filter) 2025/03/31 04:26:46 DEBUG : potato2: Excluded 2025/03/31 04:26:46 DEBUG : Local file system at /tmp/rclone2240301564: Waiting for checks to finish 2025/03/31 04:26:46 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:26:46 DEBUG : empty space: Unchanged skipping 2025/03/31 04:26:46 DEBUG : Local file system at /tmp/rclone2240301564: Waiting for transfers to finish 2025/03/31 04:26:46 DEBUG : Waiting for deletions to finish 2025/03/31 04:26:46 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncWithExclude (12.14s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:26:52 DEBUG : potato2: md5 = 3c36e47fb9800dcc904d9939141364ae OK 2025/03/31 04:26:58 DEBUG : empty space: md5 = 914dbf3a75d5cfefb473e8677652d24c OK 2025/03/31 04:27:03 DEBUG : enormous: md5 = 1e0278cc80ba84063fd0f8521bb91e25 OK 2025/03/31 04:27:08 DEBUG : enormous: Excluded (Size Filter) 2025/03/31 04:27:08 DEBUG : enormous: Excluded 2025/03/31 04:27:08 DEBUG : potato2: Excluded (Size Filter) 2025/03/31 04:27:08 DEBUG : potato2: Excluded 2025/03/31 04:27:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:27:08 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:27:08 DEBUG : empty space: Unchanged skipping 2025/03/31 04:27:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:27:08 DEBUG : Waiting for deletions to finish 2025/03/31 04:27:09 INFO : potato2: Deleted 2025/03/31 04:27:14 INFO : enormous: Deleted 2025/03/31 04:27:14 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:27:19 DEBUG : Local file system at /tmp/rclone2240301564: Waiting for checks to finish 2025/03/31 04:27:19 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:27:19 DEBUG : empty space: Unchanged skipping 2025/03/31 04:27:19 DEBUG : Local file system at /tmp/rclone2240301564: Waiting for transfers to finish 2025/03/31 04:27:19 DEBUG : Waiting for deletions to finish 2025/03/31 04:27:19 INFO : enormous: Deleted 2025/03/31 04:27:19 INFO : potato2: Deleted 2025/03/31 04:27:19 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (37.92s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:27:35 DEBUG : one: md5 = e497d0383bb263539fbb54a522d72c30 OK 2025/03/31 04:27:41 DEBUG : two: md5 = 9350603ea72898c6d2f096327454b19f OK 2025/03/31 04:27:41 DEBUG : three: md5 = c29d5c28af35f9914fd472491a2027b5 OK 2025/03/31 04:27:46 DEBUG : four: md5 = c63ae2d2afceadf869f47cbf1cafc72a OK 2025/03/31 04:27:57 DEBUG : five: Need to transfer - File not found at Destination 2025/03/31 04:27:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:27:57 DEBUG : three: Sizes identical 2025/03/31 04:27:57 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/03/31 04:28:02 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/03/31 04:28:02 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/03/31 04:28:02 DEBUG : five: md5 = 2d8a8412707623a860e96f4f5c632870 OK 2025/03/31 04:28:02 INFO : five: Copied (new) 2025/03/31 04:28:02 DEBUG : one: Destination is newer than source, skipping 2025/03/31 04:28:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:28:02 DEBUG : two: md5 = b86be26868e19be9877846ddfbec3c4b OK 2025/03/31 04:28:02 INFO : two: Copied (replaced existing) 2025/03/31 04:28:07 DEBUG : four: md5 = 941215a4d1a16dff6d02b85d91dfb195 OK 2025/03/31 04:28:07 INFO : four: Copied (replaced existing) 2025/03/31 04:28:07 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (73.67s) === 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-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2025/03/31 04:28:43 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Ignoring --track-renames as the source and destination do not have a common hash 2025/03/31 04:28:43 DEBUG : potato: Need to transfer - File not found at Destination 2025/03/31 04:28:43 DEBUG : yam: Need to transfer - File not found at Destination 2025/03/31 04:28:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:28:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:28:44 DEBUG : potato: md5 = 24a5caa557ff5be52ea2656306f017f8 OK 2025/03/31 04:28:44 INFO : potato: Copied (new) 2025/03/31 04:28:44 DEBUG : yam: md5 = 9f9391ee98209cc6b7894c4fac97ff4e OK 2025/03/31 04:28:44 INFO : yam: Copied (new) 2025/03/31 04:28:44 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:28:44 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Ignoring --track-renames as the source and destination do not have a common hash 2025/03/31 04:28:44 DEBUG : yaml: Need to transfer - File not found at Destination 2025/03/31 04:28:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:28:44 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:28:44 DEBUG : potato: Unchanged skipping 2025/03/31 04:28:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:28:44 DEBUG : yaml: md5 = 925e567ddda75d07ed8cab2a81ff6443 OK 2025/03/31 04:28:44 INFO : yaml: Copied (new) 2025/03/31 04:28:44 DEBUG : Waiting for deletions to finish 2025/03/31 04:28:44 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (2.36s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2025/03/31 04:28:46 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Making map for --track-renames 2025/03/31 04:28:46 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Finished making map for --track-renames 2025/03/31 04:28:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:28:46 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/31 04:28:46 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/03/31 04:28:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for renames to finish 2025/03/31 04:28:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:28:46 DEBUG : potato: md5 = 067a21048370de97e027c0241f614f79 OK 2025/03/31 04:28:46 INFO : potato: Copied (new) 2025/03/31 04:28:46 DEBUG : yam: md5 = fb3814f6894c0bf95196a6fb9c971867 OK 2025/03/31 04:28:46 INFO : yam: Copied (new) 2025/03/31 04:28:46 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:28:46 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Making map for --track-renames 2025/03/31 04:28:46 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Finished making map for --track-renames 2025/03/31 04:28:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:28:46 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:28:46 DEBUG : potato: Unchanged skipping 2025/03/31 04:28:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for renames to finish 2025/03/31 04:28:57 INFO : yam: Copied (server-side copy) to: yaml 2025/03/31 04:28:57 INFO : yam: Deleted 2025/03/31 04:28:57 INFO : yaml: Renamed from "yam" 2025/03/31 04:28:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:28:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (12.29s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2025/03/31 04:28:58 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Making map for --track-renames 2025/03/31 04:28:58 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Finished making map for --track-renames 2025/03/31 04:28:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:28:58 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/31 04:28:58 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/03/31 04:28:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for renames to finish 2025/03/31 04:28:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:28:58 DEBUG : potato: md5 = d28dbd1299b4b6c6e3e61c3354c10af0 OK 2025/03/31 04:28:58 INFO : potato: Copied (new) 2025/03/31 04:28:58 DEBUG : sub/yam: md5 = 6688ff9f7397d74794a7c5e8074fcc7c OK 2025/03/31 04:28:58 INFO : sub/yam: Copied (new) 2025/03/31 04:28:58 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:28:59 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:28:59 DEBUG : potato: Unchanged skipping 2025/03/31 04:28:59 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Making map for --track-renames 2025/03/31 04:28:59 INFO : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Finished making map for --track-renames 2025/03/31 04:28:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:28:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for renames to finish 2025/03/31 04:29:09 INFO : sub/yam: Copied (server-side copy) to: yam 2025/03/31 04:29:09 INFO : sub/yam: Deleted 2025/03/31 04:29:09 INFO : yam: Renamed from "sub/yam" 2025/03/31 04:29:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:29:09 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (12.63s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:29:10 DEBUG : Creating backend with remote "/tmp/rclone2240301564/dir1" 2025/03/31 04:29:10 DEBUG : Config file has changed externally - reloading 2025/03/31 04:29:10 DEBUG : Creating backend with remote "/tmp/rclone2240301564/dir2" 2025/03/31 04:29:10 DEBUG : Local file system at /tmp/rclone2240301564/dir2: Using server-side directory move 2025/03/31 04:29:10 INFO : Local file system at /tmp/rclone2240301564/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/03/31 04:29:11 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/03/31 04:29:11 DEBUG : Local file system at /tmp/rclone2240301564/dir2: Waiting for checks to finish 2025/03/31 04:29:11 INFO : file1.txt: Moved (server-side) 2025/03/31 04:29:11 DEBUG : Local file system at /tmp/rclone2240301564/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.11s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:29:11 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:29:11 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/03/31 04:29:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:29:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:29:11 DEBUG : sub dir/hello world: md5 = ba40765729d0d4cc606ff32f2af5e75b OK 2025/03/31 04:29:11 INFO : sub dir/hello world: Copied (new) 2025/03/31 04:29:11 INFO : sub dir/hello world: Deleted 2025/03/31 04:29:16 DEBUG : nested/sub dir/file: md5 = e41bca423f3862dd9b09da6fac489f66 OK 2025/03/31 04:29:16 INFO : nested/sub dir/file: Copied (new) 2025/03/31 04:29:16 INFO : nested/sub dir/file: Deleted 2025/03/31 04:29:16 INFO : sub dir: Removing directory 2025/03/31 04:29:16 INFO : nested/sub dir: Removing directory 2025/03/31 04:29:16 INFO : nested: Removing directory 2025/03/31 04:29:16 DEBUG : Local file system at /tmp/rclone2240301564: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (11.74s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:29:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/31 04:29:23 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/03/31 04:29:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:29:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:29:23 DEBUG : sub dir/hello world: md5 = dc3471002fd226e6433eca47857cdbf5 OK 2025/03/31 04:29:23 INFO : sub dir/hello world: Copied (new) 2025/03/31 04:29:23 INFO : sub dir/hello world: Deleted 2025/03/31 04:29:28 DEBUG : nested/sub dir/file: md5 = 3d781cb58b9659cc385727e15bac931b OK 2025/03/31 04:29:28 INFO : nested/sub dir/file: Copied (new) 2025/03/31 04:29:28 INFO : nested/sub dir/file: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (21.42s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:29:44 DEBUG : existing: Need to transfer - File not found at Destination 2025/03/31 04:29:44 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/03/31 04:29:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:29:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:29:49 DEBUG : existing: md5 = a815ab6339d6a225e77cb782afd74cac OK 2025/03/31 04:29:49 INFO : existing: Copied (new) 2025/03/31 04:29:49 INFO : existing: Deleted 2025/03/31 04:29:49 DEBUG : existing-b: md5 = 8d8222e83bdacabb9789d0afb69b42ac OK 2025/03/31 04:29:49 INFO : existing-b: Copied (new) 2025/03/31 04:29:49 INFO : existing-b: Deleted 2025/03/31 04:29:50 DEBUG : existing: Destination exists, skipping 2025/03/31 04:29:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:29:55 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/03/31 04:29:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:29:55 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (26.99s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:30:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kacilox0puxi" 2025/03/31 04:30:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kacilox0puxi.bin" 2025/03/31 04:30:11 DEBUG : Swift container crypt path rclone-test-kacilox0puxi.bin: Auto set use_segments_container to true 2025/03/31 04:30:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kacilox0puxi" 2025/03/31 04:30:17 DEBUG : Swift container crypt path rclone-test-kacilox0puxi: Auto set use_segments_container to true 2025/03/31 04:30:23 DEBUG : potato2: md5 = c4065bcc75a29f2b5adcf58b99d8aad4 OK 2025/03/31 04:30:28 DEBUG : empty space: md5 = 13eebf65e02edfd36de98447578acbbf OK 2025/03/31 04:30:28 DEBUG : potato3: md5 = b13ed40fd236c9cbece483714a099047 OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare' -> Encrypted drive 'TestCryptSwift:rclone-test-kacilox0puxi' 2025/03/31 04:30:29 DEBUG : empty space: md5 = 7819b1a60beac295138d299c9c572349 OK 2025/03/31 04:30:30 DEBUG : potato3: md5 = 20d8b7ec08621eb1463fa67295b46aea OK 2025/03/31 04:30:30 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:30:30 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/31 04:30:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kacilox0puxi': Waiting for checks to finish 2025/03/31 04:30:30 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:30:30 DEBUG : empty space: Unchanged skipping 2025/03/31 04:30:35 INFO : empty space: Deleted 2025/03/31 04:30:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kacilox0puxi': Waiting for transfers to finish 2025/03/31 04:30:36 INFO : potato3: Copied (server-side copy) 2025/03/31 04:30:36 INFO : potato3: Deleted 2025/03/31 04:30:36 INFO : potato2: Copied (server-side copy) 2025/03/31 04:30:36 INFO : potato2: Deleted 2025/03/31 04:30:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-sahivan0duji" 2025/03/31 04:30:37 DEBUG : Config file has changed externally - reloading 2025/03/31 04:30:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sahivan0duji.bin" 2025/03/31 04:30:37 DEBUG : Swift container crypt path rclone-test-sahivan0duji.bin: Auto set use_segments_container to true 2025/03/31 04:30:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sahivan0duji" 2025/03/31 04:30:43 DEBUG : Swift container crypt path rclone-test-sahivan0duji: Auto set use_segments_container to true 2025/03/31 04:30:49 DEBUG : empty space: Need to transfer - File not found at Destination 2025/03/31 04:30:49 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:30:49 DEBUG : potato3: Need to transfer - File not found at Destination 2025/03/31 04:30:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sahivan0duji': Waiting for checks to finish 2025/03/31 04:30:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sahivan0duji': Waiting for transfers to finish 2025/03/31 04:30:54 INFO : potato3: Copied (server-side copy) 2025/03/31 04:30:54 INFO : potato3: Deleted 2025/03/31 04:30:59 INFO : empty space: Copied (server-side copy) 2025/03/31 04:30:59 INFO : potato2: Copied (server-side copy) 2025/03/31 04:30:59 INFO : empty space: Deleted 2025/03/31 04:31:00 INFO : potato2: Deleted 2025/03/31 04:31:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sahivan0duji': Purge remote 2025/03/31 04:31:10 DEBUG : Waiting for deletions to finish 2025/03/31 04:31:10 INFO : potato3.bin: Deleted 2025/03/31 04:31:15 INFO : empty space.bin: Deleted 2025/03/31 04:31:20 INFO : potato2.bin: Deleted 2025/03/31 04:31:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kacilox0puxi': Purge remote 2025/03/31 04:31:20 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (70.02s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:31:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-nuwacos6bawe" 2025/03/31 04:31:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nuwacos6bawe.bin" 2025/03/31 04:31:21 DEBUG : Swift container crypt path rclone-test-nuwacos6bawe.bin: Auto set use_segments_container to true 2025/03/31 04:31:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nuwacos6bawe" 2025/03/31 04:31:27 DEBUG : Swift container crypt path rclone-test-nuwacos6bawe: Auto set use_segments_container to true 2025/03/31 04:31:33 DEBUG : potato2: md5 = 0020b2c794187438fd2d2bebdbd22a58 OK 2025/03/31 04:31:38 DEBUG : empty space: md5 = 7cc6d42cc3d26eaf98bdfe466806732b OK 2025/03/31 04:31:38 DEBUG : potato3: md5 = 884f440e52825e319e60a365dc2b7bda OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare' -> Encrypted drive 'TestCryptSwift:rclone-test-nuwacos6bawe' 2025/03/31 04:31:39 DEBUG : empty space: md5 = 502729cd16f94f6eb286a2b9d9863c61 OK 2025/03/31 04:31:44 DEBUG : potato3: md5 = 0d70355bcee98d23e236069fef75fd8d OK 2025/03/31 04:31:45 DEBUG : empty space: Excluded (Size Filter) 2025/03/31 04:31:45 DEBUG : empty space: Excluded 2025/03/31 04:31:45 DEBUG : empty space: Excluded (Size Filter) 2025/03/31 04:31:45 DEBUG : empty space: Excluded 2025/03/31 04:31:45 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:31:45 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/31 04:31:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nuwacos6bawe': Waiting for checks to finish 2025/03/31 04:31:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nuwacos6bawe': Waiting for transfers to finish 2025/03/31 04:31:50 INFO : potato2: Copied (server-side copy) 2025/03/31 04:31:50 INFO : potato2: Deleted 2025/03/31 04:31:55 INFO : potato3: Copied (server-side copy) 2025/03/31 04:31:55 INFO : potato3: Deleted 2025/03/31 04:32:01 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-dapirah5paho" 2025/03/31 04:32:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-dapirah5paho.bin" 2025/03/31 04:32:01 DEBUG : Swift container crypt path rclone-test-dapirah5paho.bin: Auto set use_segments_container to true 2025/03/31 04:32:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-dapirah5paho" 2025/03/31 04:32:07 DEBUG : Swift container crypt path rclone-test-dapirah5paho: Auto set use_segments_container to true 2025/03/31 04:32:13 DEBUG : empty space: Excluded (Size Filter) 2025/03/31 04:32:13 DEBUG : empty space: Excluded 2025/03/31 04:32:13 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:32:13 DEBUG : potato3: Need to transfer - File not found at Destination 2025/03/31 04:32:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dapirah5paho': Waiting for checks to finish 2025/03/31 04:32:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dapirah5paho': Waiting for transfers to finish 2025/03/31 04:32:23 INFO : potato2: Copied (server-side copy) 2025/03/31 04:32:23 INFO : potato2: Deleted 2025/03/31 04:32:23 INFO : potato3: Copied (server-side copy) 2025/03/31 04:32:28 INFO : potato3: Deleted 2025/03/31 04:32:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dapirah5paho': Purge remote 2025/03/31 04:32:33 DEBUG : Waiting for deletions to finish 2025/03/31 04:32:34 INFO : potato3.bin: Deleted 2025/03/31 04:32:44 INFO : potato2.bin: Deleted 2025/03/31 04:32:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nuwacos6bawe': Purge remote 2025/03/31 04:32:44 DEBUG : Waiting for deletions to finish 2025/03/31 04:32:44 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (93.47s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:32:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-puwuben2hulu" 2025/03/31 04:32:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-puwuben2hulu.bin" 2025/03/31 04:32:55 DEBUG : Swift container crypt path rclone-test-puwuben2hulu.bin: Auto set use_segments_container to true 2025/03/31 04:33:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-puwuben2hulu" 2025/03/31 04:33:01 DEBUG : Swift container crypt path rclone-test-puwuben2hulu: Auto set use_segments_container to true 2025/03/31 04:33:06 DEBUG : potato2: md5 = ba8290c90b2f02db43c8df1fdabb923b OK 2025/03/31 04:33:12 DEBUG : empty space: md5 = baf7f619585b4202dafa26636ea480bf OK 2025/03/31 04:33:12 DEBUG : potato3: md5 = 0c307cfe7fe3f614aeb98edc0fb20c69 OK 2025/03/31 04:33:12 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare' -> Encrypted drive 'TestCryptSwift:rclone-test-puwuben2hulu' 2025/03/31 04:33:18 DEBUG : empty space: md5 = a0a2e57bc110b048a72827e7be1c5f80 OK 2025/03/31 04:33:18 DEBUG : potato3: md5 = f0ee7e80412818139cd6fec888165798 OK 2025/03/31 04:33:19 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:33:19 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/31 04:33:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puwuben2hulu': Waiting for checks to finish 2025/03/31 04:33:24 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:33:24 DEBUG : empty space: Unchanged skipping 2025/03/31 04:33:24 INFO : potato3: Copied (server-side copy) 2025/03/31 04:33:24 INFO : potato3: Deleted 2025/03/31 04:33:29 INFO : empty space: Deleted 2025/03/31 04:33:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puwuben2hulu': Waiting for transfers to finish 2025/03/31 04:33:29 INFO : potato2: Copied (server-side copy) 2025/03/31 04:33:29 INFO : potato2: Deleted 2025/03/31 04:33:30 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-caqaqar0roha" 2025/03/31 04:33:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-caqaqar0roha.bin" 2025/03/31 04:33:30 DEBUG : Swift container crypt path rclone-test-caqaqar0roha.bin: Auto set use_segments_container to true 2025/03/31 04:33:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-caqaqar0roha" 2025/03/31 04:33:36 DEBUG : Swift container crypt path rclone-test-caqaqar0roha: Auto set use_segments_container to true 2025/03/31 04:33:42 INFO : tomatoDir: Making directory 2025/03/31 04:33:42 DEBUG : empty space: Need to transfer - File not found at Destination 2025/03/31 04:33:42 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/31 04:33:42 DEBUG : potato3: Need to transfer - File not found at Destination 2025/03/31 04:33:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-caqaqar0roha': Waiting for checks to finish 2025/03/31 04:33:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-caqaqar0roha': Waiting for transfers to finish 2025/03/31 04:33:48 INFO : potato3: Copied (server-side copy) 2025/03/31 04:33:48 INFO : potato3: Deleted 2025/03/31 04:33:52 INFO : potato2: Copied (server-side copy) 2025/03/31 04:33:52 INFO : empty space: Copied (server-side copy) 2025/03/31 04:33:53 INFO : empty space: Deleted 2025/03/31 04:33:58 INFO : potato2: Deleted 2025/03/31 04:33:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-caqaqar0roha': Purge remote 2025/03/31 04:33:58 DEBUG : Waiting for deletions to finish 2025/03/31 04:33:58 INFO : potato2.bin: Deleted 2025/03/31 04:33:58 INFO : potato3.bin: Deleted 2025/03/31 04:33:58 INFO : empty space.bin: Deleted 2025/03/31 04:33:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-puwuben2hulu': Purge remote 2025/03/31 04:33:58 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (64.50s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:33:59 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/rclone-move-test" 2025/03/31 04:33:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-move-test.bin" 2025/03/31 04:33:59 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-move-test.bin: Auto set use_segments_container to true 2025/03/31 04:34:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-move-test" 2025/03/31 04:34:05 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-move-test: Auto set use_segments_container to true 2025/03/31 04:34:11 DEBUG : potato2: md5 = 3b0f72d3af4dc398006ef754f415be1e OK --- PASS: TestServerSideMoveOverlap (12.74s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:34:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test" 2025/03/31 04:34:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-sync-test.bin" 2025/03/31 04:34:12 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-sync-test.bin: Auto set use_segments_container to true 2025/03/31 04:34:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-sync-test" 2025/03/31 04:34:18 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncOverlap (12.75s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:34:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test" 2025/03/31 04:34:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-sync-test.bin" 2025/03/31 04:34:25 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-sync-test.bin: Auto set use_segments_container to true 2025/03/31 04:34:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-sync-test" 2025/03/31 04:34:31 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-sync-test: Auto set use_segments_container to true 2025/03/31 04:34:36 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test-include/layer2" 2025/03/31 04:34:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-sync-test-include/layer2.bin" 2025/03/31 04:34:37 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/03/31 04:34:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-sync-test-include/layer2" 2025/03/31 04:34:42 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/03/31 04:34:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test-ignore-file" 2025/03/31 04:34:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-sync-test-ignore-file.bin" 2025/03/31 04:34:48 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/03/31 04:34:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/rclone-sync-test-ignore-file" 2025/03/31 04:34:54 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/03/31 04:35:05 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = b6718fa960ddb6e271afa17813397efc OK 2025/03/31 04:35:15 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/31 04:35:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test': Waiting for checks to finish 2025/03/31 04:35:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test': Waiting for transfers to finish 2025/03/31 04:35:15 DEBUG : Waiting for deletions to finish 2025/03/31 04:35:15 INFO : There was nothing to transfer 2025/03/31 04:35:25 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/31 04:35:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:35:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:35:25 DEBUG : Waiting for deletions to finish 2025/03/31 04:35:25 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:35:31 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/31 04:35:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/03/31 04:35:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/03/31 04:35:31 DEBUG : Waiting for deletions to finish 2025/03/31 04:35:31 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:35:36 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/31 04:35:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:35:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:35:36 DEBUG : Waiting for deletions to finish 2025/03/31 04:35:36 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:35:36 DEBUG : : Excluded 2025/03/31 04:35:36 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/31 04:35:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/03/31 04:35:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/03/31 04:35:36 DEBUG : Waiting for deletions to finish 2025/03/31 04:35:36 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (80.36s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:35:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/dst" 2025/03/31 04:35:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst.bin" 2025/03/31 04:35:45 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst.bin: Auto set use_segments_container to true 2025/03/31 04:35:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst" 2025/03/31 04:35:51 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst: Auto set use_segments_container to true 2025/03/31 04:35:56 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/CompareDest" 2025/03/31 04:35:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/CompareDest.bin" 2025/03/31 04:35:57 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/CompareDest.bin: Auto set use_segments_container to true 2025/03/31 04:36:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/CompareDest" 2025/03/31 04:36:03 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/CompareDest: Auto set use_segments_container to true 2025/03/31 04:36:13 DEBUG : one: Need to transfer - File not found at Destination 2025/03/31 04:36:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:36:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:36:19 DEBUG : one: md5 = da9197061de30777fc59739e189da475 OK 2025/03/31 04:36:19 INFO : one: Copied (new) 2025/03/31 04:36:19 DEBUG : Waiting for deletions to finish 2025/03/31 04:36:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:36:19 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/31 04:36:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:36:30 DEBUG : one: md5 = 55c7e1580b0eaa5a83b5d85031f9aebe OK 2025/03/31 04:36:30 INFO : one: Copied (replaced existing) 2025/03/31 04:36:30 DEBUG : Waiting for deletions to finish 2025/03/31 04:36:35 DEBUG : dst/one: md5 = 3648fad5ae157efe47c12d8d2f11b4b6 OK 2025/03/31 04:36:41 DEBUG : CompareDest/one: md5 = fd41f1640a467a157c23eb98693e125c OK 2025/03/31 04:36:46 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/31 04:36:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:36:46 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:36:46 DEBUG : one: Destination found in --compare-dest, skipping 2025/03/31 04:36:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:36:46 DEBUG : Waiting for deletions to finish 2025/03/31 04:36:46 INFO : There was nothing to transfer 2025/03/31 04:36:57 DEBUG : CompareDest/two: md5 = 7526548b4e37661add93cc7efc8f7261 OK 2025/03/31 04:37:02 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:37:02 DEBUG : two: Destination found in --compare-dest, skipping 2025/03/31 04:37:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/31 04:37:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:37:02 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:37:02 DEBUG : one: Destination found in --compare-dest, skipping 2025/03/31 04:37:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:37:02 DEBUG : Waiting for deletions to finish 2025/03/31 04:37:02 INFO : There was nothing to transfer 2025/03/31 04:37:12 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:37:12 DEBUG : two: Destination found in --compare-dest, skipping 2025/03/31 04:37:12 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/31 04:37:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:37:17 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:37:17 DEBUG : one: Destination found in --compare-dest, skipping 2025/03/31 04:37:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:37:17 DEBUG : Waiting for deletions to finish 2025/03/31 04:37:17 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2025/03/31 04:37:33 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/03/31 04:37:33 DEBUG : two: Need to transfer - File not found at Destination 2025/03/31 04:37:33 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/31 04:37:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:37:33 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:37:33 DEBUG : one: Destination found in --compare-dest, skipping 2025/03/31 04:37:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:37:38 DEBUG : two: md5 = 27143d959746920cf9066dcf6991a532 OK 2025/03/31 04:37:38 INFO : two: Copied (new) 2025/03/31 04:37:38 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (154.68s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:38:20 DEBUG : pre-dest1/1: md5 = 2b9a052a0fbd40fb81565a2abb2a2147 OK 2025/03/31 04:38:20 DEBUG : pre-dest2/2: md5 = cc5547d9510626bfd780cc2de69571c7 OK 2025/03/31 04:38:21 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/dest" 2025/03/31 04:38:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dest.bin" 2025/03/31 04:38:21 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dest.bin: Auto set use_segments_container to true 2025/03/31 04:38:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dest" 2025/03/31 04:38:27 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dest: Auto set use_segments_container to true 2025/03/31 04:38:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/pre-dest1" 2025/03/31 04:38:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/pre-dest1.bin" 2025/03/31 04:38:33 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/pre-dest1.bin: Auto set use_segments_container to true 2025/03/31 04:38:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/pre-dest1" 2025/03/31 04:38:39 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/pre-dest1: Auto set use_segments_container to true 2025/03/31 04:38:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/pre-dest2" 2025/03/31 04:38:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/pre-dest2.bin" 2025/03/31 04:38:45 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/pre-dest2.bin: Auto set use_segments_container to true 2025/03/31 04:38:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/pre-dest2" 2025/03/31 04:38:51 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/pre-dest2: Auto set use_segments_container to true 2025/03/31 04:38:56 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:38:56 DEBUG : 1: Destination found in --compare-dest, skipping 2025/03/31 04:39:02 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:39:02 DEBUG : 2: Destination found in --compare-dest, skipping 2025/03/31 04:39:12 DEBUG : 3: Need to transfer - File not found at Destination 2025/03/31 04:39:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dest': Waiting for checks to finish 2025/03/31 04:39:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dest': Waiting for transfers to finish 2025/03/31 04:39:13 DEBUG : 3: md5 = 8a025914939b7e63f5cd5ffe01d2dc81 OK 2025/03/31 04:39:13 INFO : 3: Copied (new) 2025/03/31 04:39:13 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (54.70s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:39:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/dst" 2025/03/31 04:39:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst.bin" 2025/03/31 04:39:15 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst.bin: Auto set use_segments_container to true 2025/03/31 04:39:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst" 2025/03/31 04:39:20 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst: Auto set use_segments_container to true 2025/03/31 04:39:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/CopyDest" 2025/03/31 04:39:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/CopyDest.bin" 2025/03/31 04:39:26 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/CopyDest.bin: Auto set use_segments_container to true 2025/03/31 04:39:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/CopyDest" 2025/03/31 04:39:32 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/CopyDest: Auto set use_segments_container to true 2025/03/31 04:39:43 DEBUG : one: Need to transfer - File not found at Destination 2025/03/31 04:39:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:39:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:39:48 DEBUG : one: md5 = c7f3ee47234e962853e5de45f80c1726 OK 2025/03/31 04:39:48 INFO : one: Copied (new) 2025/03/31 04:39:48 DEBUG : Waiting for deletions to finish 2025/03/31 04:39:49 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/31 04:39:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:39:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:39:59 DEBUG : one: md5 = 4ab8ed750d1bc6cbecd607f530124283 OK 2025/03/31 04:39:59 INFO : one: Copied (replaced existing) 2025/03/31 04:39:59 DEBUG : Waiting for deletions to finish 2025/03/31 04:40:10 DEBUG : dst/one: md5 = 9783b5fb531920f4ed8274edff07c931 OK 2025/03/31 04:40:10 DEBUG : CopyDest/one: md5 = 6d11999003caaa8715ba01d20651eebe OK 2025/03/31 04:40:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/BackupDir" 2025/03/31 04:40:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/BackupDir.bin" 2025/03/31 04:40:11 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/BackupDir.bin: Auto set use_segments_container to true 2025/03/31 04:40:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/BackupDir" 2025/03/31 04:40:17 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/BackupDir: Auto set use_segments_container to true 2025/03/31 04:40:22 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/31 04:40:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:40:22 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:40:22 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/31 04:40:38 INFO : one: Copied (server-side copy) 2025/03/31 04:40:43 INFO : one: Deleted 2025/03/31 04:40:58 INFO : one: Copied (server-side copy) 2025/03/31 04:40:58 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/03/31 04:40:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:40:58 DEBUG : Waiting for deletions to finish 2025/03/31 04:40:59 DEBUG : CopyDest/two: md5 = d773095a95385368f9b42b6b3cb13abb OK 2025/03/31 04:41:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:41:15 INFO : two: Copied (server-side copy) 2025/03/31 04:41:15 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/03/31 04:41:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:41:15 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:41:15 DEBUG : one: Unchanged skipping 2025/03/31 04:41:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:41:15 DEBUG : Waiting for deletions to finish 2025/03/31 04:41:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:41:21 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:41:21 DEBUG : two: Unchanged skipping 2025/03/31 04:41:25 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:41:25 DEBUG : one: Unchanged skipping 2025/03/31 04:41:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:41:25 DEBUG : Waiting for deletions to finish 2025/03/31 04:41:25 INFO : There was nothing to transfer 2025/03/31 04:41:36 DEBUG : CopyDest/three: md5 = 9302eda7311e49ab0c8b979713f77aba OK 2025/03/31 04:41:47 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/03/31 04:41:47 DEBUG : three: Destination not found in --copy-dest 2025/03/31 04:41:47 DEBUG : three: Need to transfer - File not found at Destination 2025/03/31 04:41:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:41:47 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:41:47 DEBUG : one: Unchanged skipping 2025/03/31 04:41:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:41:52 DEBUG : two: Unchanged skipping 2025/03/31 04:41:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:41:52 DEBUG : three: md5 = 83b0c7415b9e9c5a5299899785dbde93 OK 2025/03/31 04:41:52 INFO : three: Copied (new) 2025/03/31 04:41:52 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (189.96s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:42:29 DEBUG : dst/one: md5 = faf7f9f1481f098fdb51b79aa3a1ce40 OK 2025/03/31 04:42:34 DEBUG : dst/two: md5 = 6396cdb7974b70a4ea108e6971022412 OK 2025/03/31 04:42:35 DEBUG : dst/three.txt: md5 = f322fdfb84f4a1a860cda67908e8fa21 OK 2025/03/31 04:42:40 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/dst" 2025/03/31 04:42:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst.bin" 2025/03/31 04:42:41 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst.bin: Auto set use_segments_container to true 2025/03/31 04:42:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst" 2025/03/31 04:42:46 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst: Auto set use_segments_container to true 2025/03/31 04:42:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/backup" 2025/03/31 04:42:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/backup.bin" 2025/03/31 04:42:52 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/backup.bin: Auto set use_segments_container to true 2025/03/31 04:42:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/backup" 2025/03/31 04:42:58 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/backup: Auto set use_segments_container to true 2025/03/31 04:43:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/31 04:43:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:43:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:43:04 DEBUG : two: Unchanged skipping 2025/03/31 04:43:20 INFO : one: Copied (server-side copy) 2025/03/31 04:43:25 INFO : one: Deleted 2025/03/31 04:43:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:43:30 DEBUG : one: md5 = 0044d08750b39e3a94d2a8bfd0f446a0 OK 2025/03/31 04:43:30 INFO : one: Copied (new) 2025/03/31 04:43:30 DEBUG : Waiting for deletions to finish 2025/03/31 04:43:46 INFO : three.txt: Copied (server-side copy) 2025/03/31 04:43:46 INFO : three.txt: Deleted 2025/03/31 04:43:46 INFO : three.txt: Moved into backup dir 2025/03/31 04:43:57 DEBUG : dst/three.txt: md5 = cc60f4c4ced65ffb87327d2b863c1baa OK 2025/03/31 04:44:12 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/31 04:44:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:44:12 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:44:12 DEBUG : two: Unchanged skipping 2025/03/31 04:44:23 INFO : one: Copied (server-side copy) 2025/03/31 04:44:28 INFO : one: Deleted 2025/03/31 04:44:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:44:33 DEBUG : one: md5 = 96251894b8416c9d9a52778bf3668906 OK 2025/03/31 04:44:33 INFO : one: Copied (new) 2025/03/31 04:44:33 DEBUG : Waiting for deletions to finish 2025/03/31 04:44:49 INFO : three.txt: Copied (server-side copy) 2025/03/31 04:44:49 INFO : three.txt: Deleted 2025/03/31 04:44:49 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (186.29s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:45:36 DEBUG : dst/one: md5 = b01334d0eba410ff77a30585af6032f1 OK 2025/03/31 04:45:41 DEBUG : dst/two: md5 = 1dd1ddbe69d52e6ca740f36e297c5270 OK 2025/03/31 04:45:41 DEBUG : dst/three.txt: md5 = d8981efe3696fe4a988b07f08630becc OK 2025/03/31 04:45:46 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/dst" 2025/03/31 04:45:46 DEBUG : Config file has changed externally - reloading 2025/03/31 04:45:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst.bin" 2025/03/31 04:45:47 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst.bin: Auto set use_segments_container to true 2025/03/31 04:45:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst" 2025/03/31 04:45:53 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst: Auto set use_segments_container to true 2025/03/31 04:45:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/backup" 2025/03/31 04:45:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/backup.bin" 2025/03/31 04:45:59 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/backup.bin: Auto set use_segments_container to true 2025/03/31 04:46:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/backup" 2025/03/31 04:46:05 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/backup: Auto set use_segments_container to true 2025/03/31 04:46:10 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/31 04:46:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:46:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:46:10 DEBUG : two: Unchanged skipping 2025/03/31 04:46:31 INFO : one: Copied (server-side copy) to: one.bak 2025/03/31 04:46:36 INFO : one: Deleted 2025/03/31 04:46:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:46:41 DEBUG : one: md5 = 510feed84881828d4eadaea2c0432f15 OK 2025/03/31 04:46:41 INFO : one: Copied (new) 2025/03/31 04:46:41 DEBUG : Waiting for deletions to finish 2025/03/31 04:46:52 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/31 04:46:52 INFO : three.txt: Deleted 2025/03/31 04:46:52 INFO : three.txt: Moved into backup dir 2025/03/31 04:47:03 DEBUG : dst/three.txt: md5 = d0edda5c2c6a8837f3291df40ca90524 OK 2025/03/31 04:47:18 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/31 04:47:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:47:23 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:47:23 DEBUG : two: Unchanged skipping 2025/03/31 04:47:34 INFO : one: Copied (server-side copy) to: one.bak 2025/03/31 04:47:39 INFO : one: Deleted 2025/03/31 04:47:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:47:44 DEBUG : one: md5 = 0a3e363cbc38c077757c58dbbb542ac3 OK 2025/03/31 04:47:44 INFO : one: Copied (new) 2025/03/31 04:47:44 DEBUG : Waiting for deletions to finish 2025/03/31 04:47:49 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/31 04:47:49 INFO : three.txt: Deleted 2025/03/31 04:47:49 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (175.14s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:48:31 DEBUG : dst/one: md5 = 9bcb04e5799d9e129de802f9b28a2cb8 OK 2025/03/31 04:48:36 DEBUG : dst/two: md5 = fff203477ef2e1230756ce14073d4753 OK 2025/03/31 04:48:36 DEBUG : dst/three.txt: md5 = a08cf458a33dec10546ac8a803f580f4 OK 2025/03/31 04:48:36 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/dst" 2025/03/31 04:48:36 DEBUG : Config file has changed externally - reloading 2025/03/31 04:48:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst.bin" 2025/03/31 04:48:37 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst.bin: Auto set use_segments_container to true 2025/03/31 04:48:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst" 2025/03/31 04:48:43 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst: Auto set use_segments_container to true 2025/03/31 04:48:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/backup" 2025/03/31 04:48:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/backup.bin" 2025/03/31 04:48:49 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/backup.bin: Auto set use_segments_container to true 2025/03/31 04:48:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/backup" 2025/03/31 04:48:54 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/backup: Auto set use_segments_container to true 2025/03/31 04:49:00 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/31 04:49:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:49:05 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:49:05 DEBUG : two: Unchanged skipping 2025/03/31 04:49:16 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/03/31 04:49:21 INFO : one: Deleted 2025/03/31 04:49:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:49:26 DEBUG : one: md5 = 93f486f2e4d1d74eac9af25171928820 OK 2025/03/31 04:49:26 INFO : one: Copied (new) 2025/03/31 04:49:26 DEBUG : Waiting for deletions to finish 2025/03/31 04:49:41 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/03/31 04:49:42 INFO : three.txt: Deleted 2025/03/31 04:49:42 INFO : three.txt: Moved into backup dir 2025/03/31 04:49:47 DEBUG : dst/three.txt: md5 = d2b0053524e196146f8f64853190c830 OK 2025/03/31 04:49:52 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/31 04:49:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:49:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:49:52 DEBUG : two: Unchanged skipping 2025/03/31 04:50:03 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/03/31 04:50:08 INFO : one: Deleted 2025/03/31 04:50:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:50:13 DEBUG : one: md5 = 4cb9dc290c6e50b555f7afdd5520c4f8 OK 2025/03/31 04:50:13 INFO : one: Copied (new) 2025/03/31 04:50:13 DEBUG : Waiting for deletions to finish 2025/03/31 04:50:28 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/03/31 04:50:29 INFO : three.txt: Deleted 2025/03/31 04:50:29 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (149.12s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:51:00 DEBUG : dst/one: md5 = 3a431679ddd7c0a535db2142d8d274a4 OK 2025/03/31 04:51:05 DEBUG : dst/two: md5 = 9ffad27cf7c48989e625e4e4408bd09a OK 2025/03/31 04:51:05 DEBUG : dst/three.txt: md5 = c628e665be8bc85f8b97e987289f8364 OK 2025/03/31 04:51:05 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/dst" 2025/03/31 04:51:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst.bin" 2025/03/31 04:51:06 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst.bin: Auto set use_segments_container to true 2025/03/31 04:51:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst" 2025/03/31 04:51:12 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst: Auto set use_segments_container to true 2025/03/31 04:51:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/31 04:51:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:51:17 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:51:17 DEBUG : two: Unchanged skipping 2025/03/31 04:51:33 INFO : one: Copied (server-side copy) to: one.bak 2025/03/31 04:51:38 INFO : one: Deleted 2025/03/31 04:51:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:51:43 DEBUG : one: md5 = af9ff2a7cb74ac15fc5c0acadfe3f20a OK 2025/03/31 04:51:43 INFO : one: Copied (new) 2025/03/31 04:51:43 DEBUG : Waiting for deletions to finish 2025/03/31 04:51:59 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/31 04:51:59 INFO : three.txt: Deleted 2025/03/31 04:51:59 INFO : three.txt: Moved into backup dir 2025/03/31 04:52:04 DEBUG : dst/three.txt: md5 = 27de5a3626a7cad47e4ae8f5ea723d40 OK 2025/03/31 04:52:15 DEBUG : one.bak: Excluded (Path Filter) 2025/03/31 04:52:15 DEBUG : one.bak: Excluded 2025/03/31 04:52:15 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/03/31 04:52:15 DEBUG : three.txt.bak: Excluded 2025/03/31 04:52:15 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/31 04:52:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for checks to finish 2025/03/31 04:52:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:52:15 DEBUG : two: Unchanged skipping 2025/03/31 04:52:25 INFO : one: Copied (server-side copy) to: one.bak 2025/03/31 04:52:30 INFO : one: Deleted 2025/03/31 04:52:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare/dst': Waiting for transfers to finish 2025/03/31 04:52:36 DEBUG : one: md5 = 4d6c7d5f549a0162c27b4b60e09a92db OK 2025/03/31 04:52:36 INFO : one: Copied (new) 2025/03/31 04:52:36 DEBUG : Waiting for deletions to finish 2025/03/31 04:52:46 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/31 04:52:46 INFO : three.txt: Deleted 2025/03/31 04:52:46 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (137.64s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:53:17 DEBUG : dst/one: md5 = 668a8d70336889100277e7ed97f2de19 OK 2025/03/31 04:53:22 DEBUG : dst/two: md5 = 8d2f9d1dfb3b6bfea471e192d1eebbfd OK 2025/03/31 04:53:23 DEBUG : dst/three.txt: md5 = 022327d5d12fba9994e521d07f276a44 OK 2025/03/31 04:53:23 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/dst" 2025/03/31 04:53:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst.bin" 2025/03/31 04:53:23 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst.bin: Auto set use_segments_container to true 2025/03/31 04:53:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst" 2025/03/31 04:53:29 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst: Auto set use_segments_container to true 2025/03/31 04:53:34 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/31 04:53:50 INFO : one: Copied (server-side copy) to: one.bak 2025/03/31 04:53:55 INFO : one: Deleted 2025/03/31 04:54:00 DEBUG : one: md5 = 62f10e737b789aa7df6897ec733adcb1 OK 2025/03/31 04:54:00 INFO : one: Copied (new) 2025/03/31 04:54:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:54:06 DEBUG : two: Unchanged skipping 2025/03/31 04:54:06 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/03/31 04:54:21 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/31 04:54:21 INFO : three.txt: Deleted 2025/03/31 04:54:21 DEBUG : three.txt: md5 = e267f4f209cf9b5836026a5c3595d30f OK 2025/03/31 04:54:21 INFO : three.txt: Copied (new) 2025/03/31 04:55:02 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/31 04:55:23 INFO : one: Copied (server-side copy) to: one.bak 2025/03/31 04:55:28 INFO : one: Deleted 2025/03/31 04:55:33 DEBUG : one: md5 = 9f871530347ec7ecab5d672deee95015 OK 2025/03/31 04:55:33 INFO : one: Copied (new) 2025/03/31 04:55:33 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:55:33 DEBUG : two: Unchanged skipping 2025/03/31 04:55:33 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/03/31 04:55:48 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/31 04:55:48 INFO : three.txt: Deleted 2025/03/31 04:55:49 DEBUG : three.txt: md5 = bd6fc46c8d7e760265dc2361ff2450a3 OK 2025/03/31 04:55:49 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (197.77s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:56:35 DEBUG : dst/one: md5 = 6a6327358b3e3cf5866f8cb25fcbd0f8 OK 2025/03/31 04:56:40 DEBUG : dst/two: md5 = d79ef81d9e6ef569bf732c369cd77a6f OK 2025/03/31 04:56:40 DEBUG : dst/three.txt: md5 = d084730c9d7e6657c7f32b5d7ce6365b OK 2025/03/31 04:56:41 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kirukuh9lare/dst" 2025/03/31 04:56:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst.bin" 2025/03/31 04:56:41 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst.bin: Auto set use_segments_container to true 2025/03/31 04:56:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kirukuh9lare/dst" 2025/03/31 04:56:47 DEBUG : Swift container crypt path rclone-test-kirukuh9lare/dst: Auto set use_segments_container to true 2025/03/31 04:56:53 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/31 04:57:08 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/03/31 04:57:13 INFO : one: Deleted 2025/03/31 04:57:19 DEBUG : one: md5 = e1755d6b15f90b548925283250ea8cf1 OK 2025/03/31 04:57:19 INFO : one: Copied (new) 2025/03/31 04:57:19 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:57:19 DEBUG : two: Unchanged skipping 2025/03/31 04:57:19 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/03/31 04:57:29 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/03/31 04:57:29 INFO : three.txt: Deleted 2025/03/31 04:57:29 DEBUG : three.txt: md5 = 371ef3c292fab1838474b274339183ac OK 2025/03/31 04:57:29 INFO : three.txt: Copied (new) 2025/03/31 04:57:40 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/31 04:57:56 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/03/31 04:58:01 INFO : one: Deleted 2025/03/31 04:58:06 DEBUG : one: md5 = ed93a39b2155a069178100bb4f805cd5 OK 2025/03/31 04:58:06 INFO : one: Copied (new) 2025/03/31 04:58:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:58:06 DEBUG : two: Unchanged skipping 2025/03/31 04:58:06 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/03/31 04:58:11 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/03/31 04:58:11 INFO : three.txt: Deleted 2025/03/31 04:58:12 DEBUG : three.txt: md5 = ab78e70de92d35e5b7462861edc47f6f OK 2025/03/31 04:58:12 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (128.06s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:58:38 DEBUG : Testêé: md5 = 8b9d8f9204a3ea9f399eeb266b83e3a5 OK 2025/03/31 04:58:39 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/03/31 04:58:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:58:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:58:39 DEBUG : Testêé: md5 = a1e2a071153382e11f9a769619a619eb OK 2025/03/31 04:58:39 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/03/31 04:58:39 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (1.39s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:58:40 DEBUG : existing: Need to transfer - File not found at Destination 2025/03/31 04:58:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:58:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:58:45 DEBUG : existing: md5 = 048affca08ac62cbab843e01ad2adfd3 OK 2025/03/31 04:58:45 INFO : existing: Copied (new) 2025/03/31 04:58:45 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:58:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:58:45 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/03/31 04:58:50 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/03/31 04:58:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:58:50 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': not deleting files as there were IO errors 2025/03/31 04:58:50 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncImmutable (16.55s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:59:01 DEBUG : EXISTING: md5 = f61a5b48b1661f8a214a79854da58553 OK 2025/03/31 04:59:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 04:59:06 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 04:59:06 DEBUG : existing: Unchanged skipping 2025/03/31 04:59:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 04:59:06 DEBUG : Waiting for deletions to finish 2025/03/31 04:59:06 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (15.94s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.20s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", 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-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", 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-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.55s) --- SKIP: TestMaxTransfer/Hard (0.28s) --- SKIP: TestMaxTransfer/Soft (0.10s) --- SKIP: TestMaxTransfer/Cautious (0.17s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 04:59:18 DEBUG : both0: md5 = 28c2db1260223bd68925dc5eb6b9dfd6 OK 2025/03/31 04:59:18 DEBUG : only0: md5 = 0b805768f0d193f43f813818d57d79b5 OK 2025/03/31 04:59:24 DEBUG : both1: md5 = 3b1823a9bb304b77d23e7b817cb3b27f OK 2025/03/31 04:59:24 DEBUG : only1: md5 = f0c893de8d59c435a59afdf637da28e9 OK 2025/03/31 04:59:24 DEBUG : both2: md5 = 453c5b67625f60c5af2162ffa76157a2 OK 2025/03/31 04:59:25 DEBUG : only2: md5 = dedcd731de8408f908b2c5236b5974de OK 2025/03/31 04:59:30 DEBUG : both3: md5 = cd369882890ceb3bd0dc1e2cc60dcffd OK 2025/03/31 04:59:35 DEBUG : only3: md5 = 2d8d1ba15b93de58b83a231773d574bc OK 2025/03/31 04:59:41 DEBUG : both4: md5 = a1f3f5d00e0310fca71b6708a1458e60 OK 2025/03/31 04:59:46 DEBUG : only4: md5 = caa06f7b5528ad9d6acb91f28945255a OK 2025/03/31 04:59:51 DEBUG : both5: md5 = 192a53bc68c52ed208402c842951e5b5 OK 2025/03/31 04:59:52 DEBUG : only5: md5 = 648034d530bff5cfe4d696a79fca633b OK 2025/03/31 04:59:52 DEBUG : both6: md5 = 97867f8e329c2710cb4c3949683b93ff OK 2025/03/31 04:59:58 DEBUG : only6: md5 = f955ebdf34b7be0e2192692aa27c5d1e OK 2025/03/31 05:00:03 DEBUG : both7: md5 = 1477a28a8c1bd045dac8e8cf343e3a3c OK 2025/03/31 05:00:04 DEBUG : only7: md5 = 763b16567d2edb54270234d9cae9cb7a OK 2025/03/31 05:00:10 DEBUG : both8: md5 = 01c28879e985eb0b04c537bc40a5a75f OK 2025/03/31 05:00:10 DEBUG : only8: md5 = 472e41ce2974f61eba1ec7df38a70f4f OK 2025/03/31 05:00:15 DEBUG : both9: md5 = 314383e74e26d92ef9c6993a78d9f7cb OK 2025/03/31 05:00:16 DEBUG : only9: md5 = 4fab8b711840197a27b85f17c9ec716f OK 2025/03/31 05:00:16 DEBUG : both10: md5 = fead67668e40b5d20ca5dfdf393f698b OK 2025/03/31 05:00:21 DEBUG : only10: md5 = 1bee8252467ef25a612bbf170a09b2e8 OK 2025/03/31 05:00:22 DEBUG : both11: md5 = fd6d59c114a253a08f1d83c1bbd8d680 OK 2025/03/31 05:00:27 DEBUG : only11: md5 = 1eddae55221d644d4263b2acfdb2da15 OK 2025/03/31 05:00:27 DEBUG : both12: md5 = 844db484a7bc9cb62a0eecf6f655ac2b OK 2025/03/31 05:00:32 DEBUG : only12: md5 = 3c1b7470c17b8169ebfb66cf38e67d3c OK 2025/03/31 05:00:33 DEBUG : both13: md5 = 848dabbd3fb7338220aafb93c4a30833 OK 2025/03/31 05:00:33 DEBUG : only13: md5 = 75aa9a52b5592c9cc6e13bf4265c0d3e OK 2025/03/31 05:00:34 DEBUG : both14: md5 = 26cd227ffa1e4be2fbec42b0e11dba77 OK 2025/03/31 05:00:34 DEBUG : only14: md5 = 57648b7786007780cb385f5982a04b00 OK 2025/03/31 05:00:35 DEBUG : both15: md5 = 3888b0593165cb64ba0e5aa538c8fc09 OK 2025/03/31 05:00:40 DEBUG : only15: md5 = 4bca656c6c594839db2533b036f42998 OK 2025/03/31 05:00:45 DEBUG : both16: md5 = d95feda53918a5732756e57d9cd6dabb OK 2025/03/31 05:00:50 DEBUG : only16: md5 = fc7ee763a9ad76462d36f7ca32edf7a8 OK 2025/03/31 05:00:56 DEBUG : both17: md5 = a6ea4ae1dd19b4eaa80dcc565c92b5c9 OK 2025/03/31 05:01:01 DEBUG : only17: md5 = dfbdfdc5ef088c1c02c391d583ca7d4c OK 2025/03/31 05:01:01 DEBUG : both18: md5 = 97cbd6dd1ab8f3e05ec549b14f7761b9 OK 2025/03/31 05:01:02 DEBUG : only18: md5 = 481821e3e68a19652a377f4bfa3f1953 OK 2025/03/31 05:01:07 DEBUG : both19: md5 = f47c82bfe5feec45572b126b68189047 OK 2025/03/31 05:01:08 DEBUG : only19: md5 = 6bc7be8a19ad16dbe35d0698957ee746 OK 2025/03/31 05:02:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 05:02:00 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both11: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both10: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both1: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both12: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both13: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both14: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both15: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both16: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both18: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both19: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both2: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both3: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both4: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both5: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both6: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both7: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both8: Unchanged skipping 2025/03/31 05:02:00 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:00 DEBUG : both9: Unchanged skipping 2025/03/31 05:02:05 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:05 DEBUG : both0: Unchanged skipping 2025/03/31 05:02:05 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:02:05 DEBUG : both17: Unchanged skipping 2025/03/31 05:02:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 05:02:05 DEBUG : Waiting for deletions to finish 2025/03/31 05:02:05 INFO : only19: Deleted 2025/03/31 05:02:10 INFO : only3: Deleted 2025/03/31 05:02:10 INFO : only11: Deleted 2025/03/31 05:02:10 INFO : only16: Deleted 2025/03/31 05:02:10 INFO : only9: Deleted 2025/03/31 05:02:10 INFO : only1: Deleted 2025/03/31 05:02:10 INFO : only14: Deleted 2025/03/31 05:02:10 INFO : only4: Deleted 2025/03/31 05:02:10 INFO : only8: Deleted 2025/03/31 05:02:10 INFO : only7: Deleted 2025/03/31 05:02:10 INFO : only5: Deleted 2025/03/31 05:02:11 INFO : only13: Deleted 2025/03/31 05:02:11 INFO : only18: Deleted 2025/03/31 05:02:11 INFO : only2: Deleted 2025/03/31 05:02:11 INFO : only0: Deleted 2025/03/31 05:02:15 INFO : only15: Deleted 2025/03/31 05:02:16 INFO : only6: Deleted 2025/03/31 05:02:16 INFO : only10: Deleted 2025/03/31 05:02:20 INFO : only12: Deleted 2025/03/31 05:02:25 INFO : only17: Deleted 2025/03/31 05:02:25 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (292.50s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 05:04:10 DEBUG : both0: md5 = 429f8d5d5a7bcf17ae8eb7613b2c20b8 OK 2025/03/31 05:04:11 DEBUG : only0: md5 = 43faa11bda74625a3287fcd0e9561cec OK 2025/03/31 05:04:16 DEBUG : both1: md5 = c999f65c74ed4d70b5b2746355bdf79f OK 2025/03/31 05:04:16 DEBUG : only1: md5 = 5d7a07cc9f371f64f5242dd0e91bfbd3 OK 2025/03/31 05:04:16 DEBUG : both2: md5 = 600296e40d73f9c86663a4efda8898f5 OK 2025/03/31 05:04:16 DEBUG : only2: md5 = 1abd2355ddea71777d77eef41316223d OK 2025/03/31 05:04:21 DEBUG : both3: md5 = 2d840a5d0ee4f5d2ef805f38917250ea OK 2025/03/31 05:04:27 DEBUG : only3: md5 = 7a5f54349d757c95bee76e3cdb94249d OK 2025/03/31 05:04:32 DEBUG : both4: md5 = 35ad2c1be6dd7830028bab9073cd0413 OK 2025/03/31 05:04:37 DEBUG : only4: md5 = 56443ce2742247c779ec3f58e62300b1 OK 2025/03/31 05:04:42 DEBUG : both5: md5 = de9dc4074d629d7ffc7b0fa3be13a604 OK 2025/03/31 05:04:42 DEBUG : only5: md5 = e54583c8810ba67f1f1b2cd5fa944c55 OK 2025/03/31 05:04:42 DEBUG : both6: md5 = 551693149ed8f951bbc1b24d6c70e973 OK 2025/03/31 05:04:47 DEBUG : only6: md5 = 64371eb93c9f4842319263d9b73c71e9 OK 2025/03/31 05:04:53 DEBUG : both7: md5 = 6e4ac352b9d6a4ef728d3911d7fa6d14 OK 2025/03/31 05:04:53 DEBUG : only7: md5 = 8bcfa884b5d7ec60ea17a3c382cd85b7 OK 2025/03/31 05:04:58 DEBUG : both8: md5 = 3308a8c36fdc05366faa5400a158fdd6 OK 2025/03/31 05:04:58 DEBUG : only8: md5 = 706f876848e4a2643e28ef07d9cca910 OK 2025/03/31 05:05:03 DEBUG : both9: md5 = d5a6a0729dae1d56d864718deaccca98 OK 2025/03/31 05:05:03 DEBUG : only9: md5 = 1761484c1fe0674d78fb1c4c783ffde9 OK 2025/03/31 05:05:04 DEBUG : both10: md5 = 92309f4532b42ae9a9c6715c6df63ad2 OK 2025/03/31 05:05:09 DEBUG : only10: md5 = c53fc168252757f9aa41aed101ea0df2 OK 2025/03/31 05:05:09 DEBUG : both11: md5 = ec61856ae7d3c073cffd0478f364994f OK 2025/03/31 05:05:14 DEBUG : only11: md5 = a008d43c82384e19521f0286900f7ea9 OK 2025/03/31 05:05:14 DEBUG : both12: md5 = 24a0f1b1a12e8dcd1a28d7f383e1a850 OK 2025/03/31 05:05:19 DEBUG : only12: md5 = f8ab7fbdd5f8edfaf54b143df0f3a44a OK 2025/03/31 05:05:19 DEBUG : both13: md5 = ff3f70291d30d039b1988927d777f1e7 OK 2025/03/31 05:05:20 DEBUG : only13: md5 = 9544668dce920dfee98c7861bcb725c4 OK 2025/03/31 05:05:20 DEBUG : both14: md5 = 93ee6d2d27d83f18ee6f8d27932710c0 OK 2025/03/31 05:05:20 DEBUG : only14: md5 = d8b22b0cf31a2fc542a9fed56815e977 OK 2025/03/31 05:05:20 DEBUG : both15: md5 = b3c9093fd3107e81b68a6ab85614e38f OK 2025/03/31 05:05:25 DEBUG : only15: md5 = bebfccbc75c85ef432eb76e513292aa2 OK 2025/03/31 05:05:30 DEBUG : both16: md5 = 90dfbf2e03bbf5a532b0efb2c998540c OK 2025/03/31 05:05:36 DEBUG : only16: md5 = 727414386143f4a9ed83258ecdaf4bf6 OK 2025/03/31 05:05:41 DEBUG : both17: md5 = d36080b3fb6fa1feef381b461a5f5999 OK 2025/03/31 05:05:46 DEBUG : only17: md5 = 3781dfc33004a84f1849ceae5efa468e OK 2025/03/31 05:05:46 DEBUG : both18: md5 = 1cce498d030fa8d7620d3e80181b43a7 OK 2025/03/31 05:05:46 DEBUG : only18: md5 = 310a71a8ce99316f253bb6f0ce73d8d9 OK 2025/03/31 05:05:52 DEBUG : both19: md5 = 122d18d8d2af3cfb6de730d06f2c276c OK 2025/03/31 05:05:52 DEBUG : only19: md5 = 5521b10cd888b830e41809adc7bbf6fc OK 2025/03/31 05:06:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for checks to finish 2025/03/31 05:06:19 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both1: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both10: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both11: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both12: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both13: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both14: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both15: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both17: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both16: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both18: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both2: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both3: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both4: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both6: Unchanged skipping 2025/03/31 05:06:19 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:19 DEBUG : both7: Unchanged skipping 2025/03/31 05:06:20 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:20 DEBUG : both8: Unchanged skipping 2025/03/31 05:06:20 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:20 DEBUG : both9: Unchanged skipping 2025/03/31 05:06:20 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/03/31 05:06:20 DEBUG : only1: md5 = 1ef4e1b390dec183fc75469517170c63 OK 2025/03/31 05:06:20 INFO : only1: Copied (replaced existing) 2025/03/31 05:06:20 DEBUG : only0: md5 = cdeffc65295aca720d538e413f374188 OK 2025/03/31 05:06:20 INFO : only0: Copied (replaced existing) 2025/03/31 05:06:20 DEBUG : only13: md5 = af5e42d10fb2a322a9e8ee1c630bc9cd OK 2025/03/31 05:06:20 INFO : only13: Copied (replaced existing) 2025/03/31 05:06:21 DEBUG : only14: md5 = ad1ba7cf1c2099a682a7ce01aebbe1e0 OK 2025/03/31 05:06:21 INFO : only14: Copied (replaced existing) 2025/03/31 05:06:24 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:24 DEBUG : both0: Unchanged skipping 2025/03/31 05:06:24 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:24 DEBUG : both19: Unchanged skipping 2025/03/31 05:06:24 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/31 05:06:24 DEBUG : both5: Unchanged skipping 2025/03/31 05:06:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Waiting for transfers to finish 2025/03/31 05:06:25 DEBUG : only12: md5 = b82fc75d331ae90bf6833983c37e8b76 OK 2025/03/31 05:06:25 INFO : only12: Copied (replaced existing) 2025/03/31 05:06:26 DEBUG : only15: md5 = 6770038d47e9c0645007590e9ab49cbb OK 2025/03/31 05:06:26 INFO : only15: Copied (replaced existing) 2025/03/31 05:06:30 DEBUG : only10: md5 = da177ae263cfc077b7d0008e4de3eeee OK 2025/03/31 05:06:30 INFO : only10: Copied (replaced existing) 2025/03/31 05:06:30 DEBUG : only11: md5 = 561a8c2bf7bc279fc858b1d558ab7986 OK 2025/03/31 05:06:30 INFO : only11: Copied (replaced existing) 2025/03/31 05:06:30 DEBUG : only18: md5 = 6ce42de10df08b31fbfb6cf7d65fc0bc OK 2025/03/31 05:06:30 INFO : only18: Copied (replaced existing) 2025/03/31 05:06:30 DEBUG : only19: md5 = 9337d16a6d8fd25840317d9708da5d67 OK 2025/03/31 05:06:30 INFO : only19: Copied (replaced existing) 2025/03/31 05:06:30 DEBUG : only2: md5 = 9883e9efcfe174173c94ad042f6d094c OK 2025/03/31 05:06:30 INFO : only2: Copied (replaced existing) 2025/03/31 05:06:31 DEBUG : only17: md5 = c59e56d2f0be626842b79f5a2cef628e OK 2025/03/31 05:06:31 INFO : only17: Copied (replaced existing) 2025/03/31 05:06:31 DEBUG : only5: md5 = 5e0d66843256bd14126acc30e7657951 OK 2025/03/31 05:06:31 INFO : only5: Copied (replaced existing) 2025/03/31 05:06:35 DEBUG : only3: md5 = 224d161b442bc887fcb520df41b64cd7 OK 2025/03/31 05:06:35 INFO : only3: Copied (replaced existing) 2025/03/31 05:06:36 DEBUG : only16: md5 = 711e01f98d363b1752d00652730fa8f6 OK 2025/03/31 05:06:36 INFO : only16: Copied (replaced existing) 2025/03/31 05:06:36 DEBUG : only7: md5 = b676108098b5b125c6ada13a295780bc OK 2025/03/31 05:06:36 INFO : only7: Copied (replaced existing) 2025/03/31 05:06:36 DEBUG : only4: md5 = 6798718cf5b58b132e1a988efc097135 OK 2025/03/31 05:06:36 INFO : only4: Copied (replaced existing) 2025/03/31 05:06:36 DEBUG : only8: md5 = 5cdfd99285aedef0ee5df8edfc126162 OK 2025/03/31 05:06:36 INFO : only8: Copied (replaced existing) 2025/03/31 05:06:36 DEBUG : only9: md5 = 039ba78e068863c4268f9a7c3c2c87c1 OK 2025/03/31 05:06:36 INFO : only9: Copied (replaced existing) 2025/03/31 05:06:41 DEBUG : only6: md5 = 4e301e73a2e9fe227e07d9eb9445c2e5 OK 2025/03/31 05:06:41 INFO : only6: Copied (replaced existing) 2025/03/31 05:06:41 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (349.51s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 05:09:55 DEBUG : empty_dir: Making directory with metadata 2025/03/31 05:09:55 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/31 05:09:55 DEBUG : empty_on_remote: Making directory with metadata 2025/03/31 05:09:55 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/31 05:09:55 INFO : empty_on_remote: Making directory 2025/03/31 05:09:55 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 05:10:00 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/03/31 05:10:00 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/03/31 05:10:00 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/03/31 05:10:00 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTime (12.03s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 05:10:07 DEBUG : empty_dir: Making directory with metadata 2025/03/31 05:10:07 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/31 05:10:07 DEBUG : empty_on_remote: Making directory with metadata 2025/03/31 05:10:07 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/31 05:10:07 INFO : empty_on_remote: Making directory 2025/03/31 05:10:07 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 05:10:12 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/03/31 05:10:12 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/03/31 05:10:12 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/03/31 05:10:12 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/03/31 05:10:12 INFO : empty_dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (11.86s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 05:10:19 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/31 05:10:19 INFO : sub dir: Making directory 2025/03/31 05:10:19 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-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (4.11s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" 2025/03/31 05:10:23 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/31 05:10:23 INFO : sub dir: Making directory 2025/03/31 05:10:23 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-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare'", Local "Local file system at /tmp/rclone2240301564", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (2.58s) PASS 2025/03/31 05:10:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kirukuh9lare': Purge remote 2025/03/31 05:10:25 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 53m43.368300629s (try 1/5)