"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2025/04/24 03:42:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu" 2025/04/24 03:42:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/24 03:42:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu.bin" 2025/04/24 03:42:09 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu.bin: Auto set use_segments_container to true 2025/04/24 03:42:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu" 2025/04/24 03:42:15 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu: Auto set use_segments_container to true 2025/04/24 03:42:21 DEBUG : Creating backend with remote "/tmp/rclone3387311013" === 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-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:42:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:42:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:42:21 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/04/24 03:42:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.60s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:42:21 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/24 03:42:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:42:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:42:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:42:27 DEBUG : sub dir/hello world: md5 = 19318ebb87efbc973399069a9207aacd OK 2025/04/24 03:42:27 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:42:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (10.99s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.20s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.20s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:42:33 DEBUG : Creating backend with remote "/non-existing" 2025/04/24 03:42:33 DEBUG : Config file has changed externally - reloading 2025/04/24 03:42:33 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/04/24 03:42:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:42:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.50s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:42:38 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:42:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:42:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:42:43 DEBUG : sub dir/hello world: md5 = b5158a3e89eb13d03166955511f6cc90 OK 2025/04/24 03:42:43 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyNoTraverse (20.90s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:42:54 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Running all checks before starting transfers 2025/04/24 03:42:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:42:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:42:54 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Checks finished, now starting transfers 2025/04/24 03:42:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:42:59 DEBUG : sub dir/hello world: md5 = 856b7c4387a5e4861f50290ed1c444b3 OK 2025/04/24 03:42:59 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyCheckFirst (21.09s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:43:15 ERROR : Ignoring --no-traverse with sync 2025/04/24 03:43:15 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:43:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:43:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:43:20 DEBUG : sub dir/hello world: md5 = d1a245ee8dd8e7c7c040bc8a35d4f90e OK 2025/04/24 03:43:20 INFO : sub dir/hello world: Copied (new) 2025/04/24 03:43:20 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncNoTraverse (10.89s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:43:26 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/04/24 03:43:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:43:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:43:31 DEBUG : hello world2: md5 = 21f41f624a9bc2bf1e9163c446673220 OK 2025/04/24 03:43:31 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyWithDepth (11.08s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:43:37 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 03:43:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:43:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:43:38 DEBUG : potato2: md5 = 99403b3051293de269e1978207764f07 OK 2025/04/24 03:43:38 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (1.56s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:43:44 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 03:43:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:43:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:43:44 DEBUG : potato2: md5 = e03601794191ff0159c30a186203990d OK 2025/04/24 03:43:44 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (6.09s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:43:45 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/04/24 03:43:45 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/24 03:43:45 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/04/24 03:43:45 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/24 03:43:45 INFO : sub dir: Making directory 2025/04/24 03:43:45 INFO : sub dir2: Making directory 2025/04/24 03:43:45 INFO : sub dir2/sub sub dir2: Making directory 2025/04/24 03:43:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:43:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:43:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:43:50 DEBUG : sub dir/hello world: md5 = 5284f1d9b8d601661fe431a70659b943 OK 2025/04/24 03:43:50 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2025/04/24 03:43:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (16.10s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:44:01 INFO : sub dir2: Making directory 2025/04/24 03:44:01 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/04/24 03:44:01 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/24 03:44:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:44:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:44:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:44:06 DEBUG : sub dir/hello world: md5 = c7c5330eb3a5a992f14dd5464bbcb06c OK 2025/04/24 03:44:06 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (15.87s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:44:17 DEBUG : sub dir2: Making directory with metadata 2025/04/24 03:44:17 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/24 03:44:17 INFO : sub dir: Making directory 2025/04/24 03:44:17 INFO : sub dir2: Making directory 2025/04/24 03:44:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:44:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:44:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:44:22 DEBUG : sub dir/hello world: md5 = 7bb7a45979eed002e8c6e41909fff5fd OK 2025/04/24 03:44:22 INFO : sub dir/hello world: Copied (new) 2025/04/24 03:44:22 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/04/24 03:44:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/04/24 03:44:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (11.10s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.18s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:44:28 INFO : sub dir2: Making directory 2025/04/24 03:44:28 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:44:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:44:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:44:33 DEBUG : sub dir/hello world: md5 = aba2b92ef8f270a3ed2835ce6f9981b5 OK 2025/04/24 03:44:33 INFO : sub dir/hello world: Copied (new) 2025/04/24 03:44:33 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (15.73s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:44:44 DEBUG : sub dir2: Making directory with metadata 2025/04/24 03:44:44 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/24 03:44:44 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/24 03:44:44 INFO : sub dir: Making directory 2025/04/24 03:44:44 INFO : sub dir2: Making directory 2025/04/24 03:44:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:44:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:44:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:44:49 DEBUG : sub dir/hello world: md5 = 73fafa72b60ba49c765ecf46d8ce034d OK 2025/04/24 03:44:49 INFO : sub dir/hello world: Copied (new) 2025/04/24 03:44:49 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/04/24 03:44:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (11.02s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.20s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:44:55 INFO : sub dir2: Making directory 2025/04/24 03:44:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:44:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:44:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:45:00 DEBUG : sub dir/hello world: md5 = e9e73f7f209c586bd0e83a26ded7542a OK 2025/04/24 03:45:00 INFO : sub dir/hello world: Copied (new) 2025/04/24 03:45:00 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (10.84s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:45:11 DEBUG : sub dir/hello world: md5 = 0b9ad2e6d962d19bb687acad01ada8a9 OK 2025/04/24 03:45:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-nodehor4seqe" 2025/04/24 03:45:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nodehor4seqe.bin" 2025/04/24 03:45:17 DEBUG : Swift container crypt path rclone-test-nodehor4seqe.bin: Auto set use_segments_container to true 2025/04/24 03:45:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nodehor4seqe" 2025/04/24 03:45:23 DEBUG : Swift container crypt path rclone-test-nodehor4seqe: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu' -> Encrypted drive 'TestCryptSwift:rclone-test-nodehor4seqe' 2025/04/24 03:45:28 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:45:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nodehor4seqe': Waiting for checks to finish 2025/04/24 03:45:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nodehor4seqe': Waiting for transfers to finish 2025/04/24 03:45:33 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:45:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nodehor4seqe': Purge remote 2025/04/24 03:45:34 DEBUG : Waiting for deletions to finish 2025/04/24 03:45:34 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (38.71s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:45:50 DEBUG : sub dir/hello world: md5 = c955e83891d3e7e8ceee4bb97e9fa1b0 OK 2025/04/24 03:45:55 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/24 03:45:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:45:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:46:00 DEBUG : sub dir/hello world: md5 = 89b6e563714260bf79c37446b27819fb OK 2025/04/24 03:46:00 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyOverSelf (21.48s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:46:11 DEBUG : sub dir/hello world: md5 = 8e69a32f47102051951ab56faffcbd3f OK 2025/04/24 03:46:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-dacufuz7yexi" 2025/04/24 03:46:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-dacufuz7yexi.bin" 2025/04/24 03:46:12 DEBUG : Swift container crypt path rclone-test-dacufuz7yexi.bin: Auto set use_segments_container to true 2025/04/24 03:46:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-dacufuz7yexi" 2025/04/24 03:46:18 DEBUG : Swift container crypt path rclone-test-dacufuz7yexi: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu' -> Encrypted drive 'TestCryptSwift:rclone-test-dacufuz7yexi' 2025/04/24 03:46:28 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:46:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dacufuz7yexi': Waiting for checks to finish 2025/04/24 03:46:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dacufuz7yexi': Waiting for transfers to finish 2025/04/24 03:46:39 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:46:49 DEBUG : sub dir/hello world: md5 = a8f043b075c5f51281f33862d607bf69 OK 2025/04/24 03:46:55 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/24 03:46:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dacufuz7yexi': Waiting for checks to finish 2025/04/24 03:46:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dacufuz7yexi': Waiting for transfers to finish 2025/04/24 03:47:10 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:47:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dacufuz7yexi': Purge remote 2025/04/24 03:47:10 DEBUG : Waiting for deletions to finish 2025/04/24 03:47:15 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (80.11s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:47:31 DEBUG : sub dir/hello world: md5 = 684c17287521729254d1992ce86a67a6 OK 2025/04/24 03:47:32 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/24 03:47:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:47:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:47:37 DEBUG : sub dir/hello world: md5 = 7db0d1abe042b242ef15432d9542a6c3 OK 2025/04/24 03:47:37 INFO : sub dir/hello world: Copied (replaced existing) 2025/04/24 03:47:37 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestMoveOverSelf (16.54s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:47:48 DEBUG : sub dir/hello world: md5 = 675a76649b1396e0a16da76569902ebe OK 2025/04/24 03:47:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-pudojuf7qani" 2025/04/24 03:47:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pudojuf7qani.bin" 2025/04/24 03:47:48 DEBUG : Swift container crypt path rclone-test-pudojuf7qani.bin: Auto set use_segments_container to true 2025/04/24 03:47:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pudojuf7qani" 2025/04/24 03:47:54 DEBUG : Swift container crypt path rclone-test-pudojuf7qani: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu' -> Encrypted drive 'TestCryptSwift:rclone-test-pudojuf7qani' 2025/04/24 03:48:00 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:48:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pudojuf7qani': Waiting for checks to finish 2025/04/24 03:48:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pudojuf7qani': Waiting for transfers to finish 2025/04/24 03:48:11 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:48:21 DEBUG : sub dir/hello world: md5 = 7805a79c0c436276818113671be32029 OK 2025/04/24 03:48:26 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/04/24 03:48:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pudojuf7qani': Waiting for checks to finish 2025/04/24 03:48:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pudojuf7qani': Waiting for transfers to finish 2025/04/24 03:48:37 INFO : sub dir/hello world: Copied (server-side copy) 2025/04/24 03:48:42 INFO : sub dir/hello world: Deleted 2025/04/24 03:48:47 DEBUG : sub dir/hello world: md5 = 77badc9bd76433e77073703d2ba6db8f OK 2025/04/24 03:48:53 DEBUG : testing file moves 2025/04/24 03:48:53 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/04/24 03:48:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pudojuf7qani': Waiting for checks to finish 2025/04/24 03:48:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pudojuf7qani': Waiting for transfers to finish 2025/04/24 03:49:08 INFO : sub dir/hello world: Copied (server-side copy) 2025/04/24 03:49:13 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:49:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pudojuf7qani': Purge remote 2025/04/24 03:49:19 DEBUG : Waiting for deletions to finish 2025/04/24 03:49:24 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (102.05s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:49:30 DEBUG : sub dir/hello world: md5 = 7c15608052a47b838bbb0444e96003cb OK 2025/04/24 03:49:30 ERROR : : error listing: directory not found 2025/04/24 03:49:30 INFO : Local file system at /tmp/rclone3387311013: Making directory 2025/04/24 03:49:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:49:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyAfterDelete (16.20s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:49:46 DEBUG : sub dir/hello world: md5 = c326a5145d419f6275e76c026e6cbdbc OK 2025/04/24 03:49:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:49:51 DEBUG : Local file system at /tmp/rclone3387311013: Waiting for checks to finish 2025/04/24 03:49:51 DEBUG : Local file system at /tmp/rclone3387311013: Waiting for transfers to finish 2025/04/24 03:49:51 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/04/24 03:49:51 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyRedownload (15.93s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:49:57 DEBUG : check sum: Need to transfer - File not found at Destination 2025/04/24 03:49:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:49:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:02 DEBUG : check sum: md5 = 8413f26413260767364f49f8fe62e981 OK 2025/04/24 03:50:02 INFO : check sum: Copied (new) 2025/04/24 03:50:02 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:50:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:50:02 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/04/24 03:50:02 DEBUG : check sum: Size of src and dst objects identical 2025/04/24 03:50:07 DEBUG : check sum: Unchanged skipping 2025/04/24 03:50:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:07 DEBUG : Waiting for deletions to finish 2025/04/24 03:50:07 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (16.43s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:50:13 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/04/24 03:50:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:50:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:18 DEBUG : sizeonly: md5 = b8c7381ebd6e1603f35a515a8be82c6b OK 2025/04/24 03:50:18 INFO : sizeonly: Copied (new) 2025/04/24 03:50:18 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:50:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:50:19 DEBUG : sizeonly: Sizes identical 2025/04/24 03:50:19 DEBUG : sizeonly: Unchanged skipping 2025/04/24 03:50:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:19 DEBUG : Waiting for deletions to finish 2025/04/24 03:50:19 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncSizeOnly (11.52s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:50:25 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/04/24 03:50:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:50:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:30 DEBUG : ignore-size: md5 = 0bd507ee89386db09cb3a51efadc3f64 OK 2025/04/24 03:50:30 INFO : ignore-size: Copied (new) 2025/04/24 03:50:30 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:50:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:50:30 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:50:30 DEBUG : ignore-size: Unchanged skipping 2025/04/24 03:50:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:30 DEBUG : Waiting for deletions to finish 2025/04/24 03:50:30 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (11.55s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:50:41 DEBUG : existing: md5 = 83233c573efa4d9bd527b1b0b04cd65f OK 2025/04/24 03:50:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:50:42 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:50:42 DEBUG : existing: Unchanged skipping 2025/04/24 03:50:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:42 DEBUG : Waiting for deletions to finish 2025/04/24 03:50:42 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:50:42 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/04/24 03:50:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:50:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:47 DEBUG : existing: md5 = 182f954aff1209e655bf740419b139b2 OK 2025/04/24 03:50:47 INFO : existing: Copied (replaced existing) 2025/04/24 03:50:47 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (16.57s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:50:53 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/24 03:50:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:50:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:58 DEBUG : existing: md5 = 6a1a5d68edb74a433b05e77e70515d42 OK 2025/04/24 03:50:58 INFO : existing: Copied (new) 2025/04/24 03:50:58 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:50:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:50:59 DEBUG : existing: Destination exists, skipping 2025/04/24 03:50:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:50:59 DEBUG : Waiting for deletions to finish 2025/04/24 03:50:59 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (11.58s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:51:05 DEBUG : b/potato: md5 = 3fb89aa927e21fb604e7f9433a0c737a OK 2025/04/24 03:51:05 DEBUG : c/non empty space: md5 = 75476d4566f7cd7abe9c1ac1ae266cd3 OK 2025/04/24 03:51:05 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/04/24 03:51:05 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/24 03:51:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:51:05 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:51:05 DEBUG : c/non empty space: Unchanged skipping 2025/04/24 03:51:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:51:06 DEBUG : a/potato2: md5 = 19dd74e2a6728b6e9fa4c6bcc5b80258 OK 2025/04/24 03:51:06 INFO : a/potato2: Copied (new) 2025/04/24 03:51:06 DEBUG : Waiting for deletions to finish 2025/04/24 03:51:06 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (2.55s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:51:12 DEBUG : empty space: md5 = 6209959b3b770ea65d9ba3e3862d1485 OK 2025/04/24 03:51:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:51:23 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/04/24 03:51:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:51:23 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/04/24 03:51:23 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:51:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:51:33 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/04/24 03:51:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:51:38 DEBUG : empty space: md5 = d5bf141c0b338a3a6207d1e224b1ee61 OK 2025/04/24 03:51:38 INFO : empty space: Copied (replaced existing) 2025/04/24 03:51:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (42.12s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:1016: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.20s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:51:50 DEBUG : foo: md5 = 4f15c49a183a87952ee6a3e917968b9e OK 2025/04/24 03:51:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:51:50 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/04/24 03:51:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:51:50 DEBUG : foo: md5 = 02e710cfba3a66bf2ab4217e5e21f2f5 OK 2025/04/24 03:51:50 INFO : foo: Copied (replaced existing) 2025/04/24 03:51:50 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (1.66s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:51:56 DEBUG : empty space: md5 = 3937d4364887cef077c916b2f35607aa OK 2025/04/24 03:51:56 DEBUG : potato: Need to transfer - File not found at Destination 2025/04/24 03:51:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:51:56 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:51:56 DEBUG : empty space: Unchanged skipping 2025/04/24 03:51:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:51:59 DEBUG : potato: md5 = 36d1c57269fae7c7d7328f44068ddfe6 OK 2025/04/24 03:51:59 INFO : potato: Copied (new) 2025/04/24 03:51:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (19.68s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:52:11 DEBUG : potato: md5 = 395e69783a1d426511cd012a53d909c5 OK 2025/04/24 03:52:11 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/04/24 03:52:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:52:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:52:11 DEBUG : potato: md5 = 2291dd6371b222abaa99615996d5950c OK 2025/04/24 03:52:11 INFO : potato: Copied (replaced existing) 2025/04/24 03:52:11 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (1.68s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:52:12 DEBUG : potato: md5 = e37bda754d48b498cf262e5825cbc86f OK 2025/04/24 03:52:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:52:13 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2025/04/24 03:52:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:52:13 DEBUG : potato: md5 = 972a4911073905a5addef4a78fae2266 OK 2025/04/24 03:52:13 INFO : potato: Copied (replaced existing) 2025/04/24 03:52:13 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (1.42s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:52:14 DEBUG : potato: md5 = e7f0d55b57cf39f5dbcba802d6be4b32 OK 2025/04/24 03:52:19 DEBUG : empty space: md5 = 1a5ef77e613dc3684f67bd45338676d2 OK 2025/04/24 03:52:19 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 03:52:19 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/04/24 03:52:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:52:24 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:52:24 DEBUG : empty space: Unchanged skipping 2025/04/24 03:52:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:52:24 DEBUG : Waiting for deletions to finish 2025/04/24 03:52:24 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (26.56s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:52:40 DEBUG : potato: md5 = c4ad4363c9312b63346995e99380588e OK 2025/04/24 03:52:46 DEBUG : empty space: md5 = f22c33d92cc75311e9ff9c14b14377c8 OK 2025/04/24 03:52:46 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 03:52:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:52:46 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:52:46 DEBUG : empty space: Unchanged skipping 2025/04/24 03:52:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:52:46 DEBUG : potato2: md5 = 23bdf4c6e1b6a23eab6b24ffae10a826 OK 2025/04/24 03:52:46 INFO : potato2: Copied (new) 2025/04/24 03:52:46 DEBUG : Waiting for deletions to finish 2025/04/24 03:52:47 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (12.39s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:52:53 DEBUG : b/potato: md5 = 29ca761215a45db5dac7b20a0c13ed17 OK 2025/04/24 03:52:53 DEBUG : c/non empty space: md5 = 42425bb15c258f767f19fd0bf5d87140 OK 2025/04/24 03:52:53 INFO : d: Making directory 2025/04/24 03:52:53 INFO : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2025/04/24 03:52:53 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/24 03:52:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:52:53 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:52:53 DEBUG : c/non empty space: Unchanged skipping 2025/04/24 03:52:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:52:54 DEBUG : a/potato2: md5 = dd747befc6eb7c7d8dd02b814f736e7b OK 2025/04/24 03:52:54 INFO : a/potato2: Copied (new) 2025/04/24 03:52:54 DEBUG : Waiting for deletions to finish 2025/04/24 03:52:54 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (2.15s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:52:55 DEBUG : b/potato: md5 = 52556a4f4563359065987a0065523c8f OK 2025/04/24 03:52:55 DEBUG : c/non empty space: md5 = 08664d6bdddc2ad18ebeccb7c815ba33 OK 2025/04/24 03:52:55 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/04/24 03:52:55 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/04/24 03:52:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:52:56 DEBUG : a/potato2: md5 = 69a1e38534d801092e48fbc7d9ed2a17 OK 2025/04/24 03:52:56 INFO : a/potato2: Copied (new) 2025/04/24 03:52:56 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:52:56 DEBUG : c/non empty space: Unchanged skipping 2025/04/24 03:52:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:52:56 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': not deleting files as there were IO errors 2025/04/24 03:52:56 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (1.99s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:52:57 DEBUG : potato: md5 = 38c12509164bed16c5e3a92120c6c6d8 OK 2025/04/24 03:53:02 DEBUG : empty space: md5 = 3d8cf408f2d31b22b83d54ccfd357548 OK 2025/04/24 03:53:07 DEBUG : Waiting for deletions to finish 2025/04/24 03:53:07 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 03:53:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:53:07 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:53:07 DEBUG : empty space: Unchanged skipping 2025/04/24 03:53:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:53:08 DEBUG : potato2: md5 = 73373afdc6b30b1c138b3a340296d717 OK 2025/04/24 03:53:08 INFO : potato2: Copied (new) 2025/04/24 03:53:08 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (26.98s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:53:24 DEBUG : potato: md5 = 50e31286a1edba63222b3af6037e92ee OK 2025/04/24 03:53:29 DEBUG : empty space: md5 = 808ecfc74e0ab6b2050d59527e8724a8 OK 2025/04/24 03:53:34 DEBUG : Waiting for deletions to finish 2025/04/24 03:53:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:53:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:53:35 INFO : potato: Deleted 2025/04/24 03:53:35 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 03:53:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:53:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:53:35 DEBUG : empty space: Unchanged skipping 2025/04/24 03:53:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:53:35 DEBUG : potato2: md5 = cb540c1973f24a89591937687c35a7a4 OK 2025/04/24 03:53:35 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (17.39s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:53:41 DEBUG : potato: md5 = 0a191e5a247972119e80ecd3dc38dd79 OK 2025/04/24 03:53:42 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 03:53:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:53:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:53:42 DEBUG : potato2: md5 = 29cbb5b714595c2a4ac301f17eb5abbd OK 2025/04/24 03:53:42 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (1.71s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:53:43 DEBUG : potato2: md5 = 78ba1e86c85fa5b1a4aaa3f64bb8bdea OK 2025/04/24 03:53:48 DEBUG : empty space: md5 = d3ea3a35822682e6e13fb4a6dbb0f947 OK 2025/04/24 03:53:48 DEBUG : enormous: Excluded (Size Filter) 2025/04/24 03:53:48 DEBUG : enormous: Excluded 2025/04/24 03:53:48 DEBUG : potato2: Excluded (Size Filter) 2025/04/24 03:53:48 DEBUG : potato2: Excluded 2025/04/24 03:53:49 DEBUG : potato2: Excluded (Size Filter) 2025/04/24 03:53:49 DEBUG : potato2: Excluded 2025/04/24 03:53:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:53:49 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:53:49 DEBUG : empty space: Unchanged skipping 2025/04/24 03:53:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:53:49 DEBUG : Waiting for deletions to finish 2025/04/24 03:53:49 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:53:54 DEBUG : enormous: Excluded (Size Filter) 2025/04/24 03:53:54 DEBUG : enormous: Excluded 2025/04/24 03:53:54 DEBUG : potato2: Excluded (Size Filter) 2025/04/24 03:53:54 DEBUG : potato2: Excluded 2025/04/24 03:53:54 DEBUG : potato2: Excluded (Size Filter) 2025/04/24 03:53:54 DEBUG : potato2: Excluded 2025/04/24 03:53:54 DEBUG : Local file system at /tmp/rclone3387311013: Waiting for checks to finish 2025/04/24 03:53:54 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:53:54 DEBUG : empty space: Unchanged skipping 2025/04/24 03:53:54 DEBUG : Local file system at /tmp/rclone3387311013: Waiting for transfers to finish 2025/04/24 03:53:54 DEBUG : Waiting for deletions to finish 2025/04/24 03:53:54 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncWithExclude (21.83s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:54:05 DEBUG : potato2: md5 = bb4e191a49c6504b7ceb317ee07a7595 OK 2025/04/24 03:54:10 DEBUG : empty space: md5 = a69dc36d9508c32262f5ea692711732b OK 2025/04/24 03:54:15 DEBUG : enormous: md5 = aab7e950bb6a8ada1d66d6275ddf458a OK 2025/04/24 03:54:21 DEBUG : enormous: Excluded (Size Filter) 2025/04/24 03:54:21 DEBUG : enormous: Excluded 2025/04/24 03:54:21 DEBUG : potato2: Excluded (Size Filter) 2025/04/24 03:54:21 DEBUG : potato2: Excluded 2025/04/24 03:54:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:54:26 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:54:26 DEBUG : empty space: Unchanged skipping 2025/04/24 03:54:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:54:26 DEBUG : Waiting for deletions to finish 2025/04/24 03:54:26 INFO : potato2: Deleted 2025/04/24 03:54:31 INFO : enormous: Deleted 2025/04/24 03:54:31 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:54:31 DEBUG : Local file system at /tmp/rclone3387311013: Waiting for checks to finish 2025/04/24 03:54:36 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:54:36 DEBUG : empty space: Unchanged skipping 2025/04/24 03:54:36 DEBUG : Local file system at /tmp/rclone3387311013: Waiting for transfers to finish 2025/04/24 03:54:36 DEBUG : Waiting for deletions to finish 2025/04/24 03:54:36 INFO : enormous: Deleted 2025/04/24 03:54:36 INFO : potato2: Deleted 2025/04/24 03:54:36 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (37.08s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:54:42 DEBUG : one: md5 = dc0f8a93780c8404346e5425cfcbc91d OK 2025/04/24 03:54:43 DEBUG : two: md5 = 54bb13d82da113bc743c71a2fc1ea7e5 OK 2025/04/24 03:54:48 DEBUG : three: md5 = e7f30bfd45913d985c136b83064bccd3 OK 2025/04/24 03:54:48 DEBUG : four: md5 = a9e4760397771685bbf9a9cf471bfe6d OK 2025/04/24 03:54:54 DEBUG : five: Need to transfer - File not found at Destination 2025/04/24 03:54:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:54:54 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/04/24 03:54:54 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/04/24 03:54:54 DEBUG : one: Destination is newer than source, skipping 2025/04/24 03:54:54 DEBUG : two: md5 = 99d8feede15299d35c358baf32413bc1 OK 2025/04/24 03:54:54 INFO : two: Copied (replaced existing) 2025/04/24 03:54:54 DEBUG : four: md5 = b4a0fb450ecc650ef9a404df884c9978 OK 2025/04/24 03:54:54 INFO : four: Copied (replaced existing) 2025/04/24 03:54:59 DEBUG : three: Sizes identical 2025/04/24 03:54:59 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/04/24 03:54:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:54:59 DEBUG : five: md5 = f4d8c3aacfaa6e7adaebef7b0e4307ac OK 2025/04/24 03:54:59 INFO : five: Copied (new) 2025/04/24 03:54:59 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (33.25s) === 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-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2025/04/24 03:55:15 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Ignoring --track-renames as the source and destination do not have a common hash 2025/04/24 03:55:15 DEBUG : potato: Need to transfer - File not found at Destination 2025/04/24 03:55:15 DEBUG : yam: Need to transfer - File not found at Destination 2025/04/24 03:55:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:55:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:55:15 DEBUG : potato: md5 = fba3e027d33f993df81807db1de1cef0 OK 2025/04/24 03:55:15 INFO : potato: Copied (new) 2025/04/24 03:55:20 DEBUG : yam: md5 = 18317df4690d5e9a5982ad8ed0a887e9 OK 2025/04/24 03:55:20 INFO : yam: Copied (new) 2025/04/24 03:55:20 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:55:26 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Ignoring --track-renames as the source and destination do not have a common hash 2025/04/24 03:55:26 DEBUG : yaml: Need to transfer - File not found at Destination 2025/04/24 03:55:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:55:26 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:55:26 DEBUG : potato: Unchanged skipping 2025/04/24 03:55:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:55:31 DEBUG : yaml: md5 = d600bf0e68ceae2bab561b533f0d553f OK 2025/04/24 03:55:31 INFO : yaml: Copied (new) 2025/04/24 03:55:31 DEBUG : Waiting for deletions to finish 2025/04/24 03:55:41 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (37.41s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2025/04/24 03:55:53 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Making map for --track-renames 2025/04/24 03:55:53 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Finished making map for --track-renames 2025/04/24 03:55:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:55:53 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/24 03:55:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for renames to finish 2025/04/24 03:55:53 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/04/24 03:55:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:55:53 DEBUG : potato: md5 = d1eeecaecaa96fee23825d876b181452 OK 2025/04/24 03:55:53 INFO : potato: Copied (new) 2025/04/24 03:55:58 DEBUG : yam: md5 = 046b25e3d156603909524f709eb28dea OK 2025/04/24 03:55:58 INFO : yam: Copied (new) 2025/04/24 03:55:58 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:55:58 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Making map for --track-renames 2025/04/24 03:55:58 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Finished making map for --track-renames 2025/04/24 03:55:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:55:58 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:55:58 DEBUG : potato: Unchanged skipping 2025/04/24 03:55:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for renames to finish 2025/04/24 03:56:18 INFO : yam: Copied (server-side copy) to: yaml 2025/04/24 03:56:24 INFO : yam: Deleted 2025/04/24 03:56:24 INFO : yaml: Renamed from "yam" 2025/04/24 03:56:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:56:24 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (42.33s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2025/04/24 03:56:35 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Making map for --track-renames 2025/04/24 03:56:35 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Finished making map for --track-renames 2025/04/24 03:56:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:56:35 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/04/24 03:56:35 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/04/24 03:56:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for renames to finish 2025/04/24 03:56:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:56:35 DEBUG : potato: md5 = f4926a053c40f1ec35bcab045b1f7915 OK 2025/04/24 03:56:35 INFO : potato: Copied (new) 2025/04/24 03:56:40 DEBUG : sub/yam: md5 = a36dadbab67b9f57f55063636b1b16e0 OK 2025/04/24 03:56:40 INFO : sub/yam: Copied (new) 2025/04/24 03:56:40 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:56:41 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:56:41 DEBUG : potato: Unchanged skipping 2025/04/24 03:56:41 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Making map for --track-renames 2025/04/24 03:56:41 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Finished making map for --track-renames 2025/04/24 03:56:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:56:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for renames to finish 2025/04/24 03:57:01 INFO : sub/yam: Copied (server-side copy) to: yam 2025/04/24 03:57:06 INFO : sub/yam: Deleted 2025/04/24 03:57:06 INFO : yam: Renamed from "sub/yam" 2025/04/24 03:57:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:57:06 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (42.55s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:57:17 DEBUG : Creating backend with remote "/tmp/rclone3387311013/dir1" 2025/04/24 03:57:17 DEBUG : Config file has changed externally - reloading 2025/04/24 03:57:17 DEBUG : Creating backend with remote "/tmp/rclone3387311013/dir2" 2025/04/24 03:57:17 DEBUG : Local file system at /tmp/rclone3387311013/dir2: Using server-side directory move 2025/04/24 03:57:17 INFO : Local file system at /tmp/rclone3387311013/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/04/24 03:57:17 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/04/24 03:57:17 DEBUG : Local file system at /tmp/rclone3387311013/dir2: Waiting for checks to finish 2025/04/24 03:57:17 DEBUG : Local file system at /tmp/rclone3387311013/dir2: Waiting for transfers to finish 2025/04/24 03:57:17 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.13s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:57:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:57:18 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/04/24 03:57:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:57:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:57:18 DEBUG : nested/sub dir/file: md5 = a41b065cbd8b1b30c078e678bc17abcf OK 2025/04/24 03:57:18 INFO : nested/sub dir/file: Copied (new) 2025/04/24 03:57:18 INFO : nested/sub dir/file: Deleted 2025/04/24 03:57:23 DEBUG : sub dir/hello world: md5 = 16f5065f335d7fe91abd711ccbd3dfa3 OK 2025/04/24 03:57:23 INFO : sub dir/hello world: Copied (new) 2025/04/24 03:57:23 INFO : sub dir/hello world: Deleted 2025/04/24 03:57:23 INFO : sub dir: Removing directory 2025/04/24 03:57:23 INFO : nested/sub dir: Removing directory 2025/04/24 03:57:23 INFO : nested: Removing directory 2025/04/24 03:57:23 DEBUG : Local file system at /tmp/rclone3387311013: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (16.21s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:57:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/04/24 03:57:34 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/04/24 03:57:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:57:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:57:34 DEBUG : nested/sub dir/file: md5 = 777a08d02c77ccc6b5d7c50e7c1cfcdc OK 2025/04/24 03:57:34 INFO : nested/sub dir/file: Copied (new) 2025/04/24 03:57:34 INFO : nested/sub dir/file: Deleted 2025/04/24 03:57:39 DEBUG : sub dir/hello world: md5 = abedc1713fc24e8c8efaf7227735e324 OK 2025/04/24 03:57:39 INFO : sub dir/hello world: Copied (new) 2025/04/24 03:57:39 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (16.18s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:57:50 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/24 03:57:50 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/04/24 03:57:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:57:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:57:55 DEBUG : existing: md5 = c9fc6f7a800dd0231df6767d75f34e0b OK 2025/04/24 03:57:55 INFO : existing: Copied (new) 2025/04/24 03:57:55 INFO : existing: Deleted 2025/04/24 03:57:56 DEBUG : existing-b: md5 = e74517cf04f479175a66a95de6050fe2 OK 2025/04/24 03:57:56 INFO : existing-b: Copied (new) 2025/04/24 03:57:56 INFO : existing-b: Deleted 2025/04/24 03:58:06 DEBUG : existing: Destination exists, skipping 2025/04/24 03:58:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 03:58:16 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/04/24 03:58:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 03:58:16 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (46.85s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 03:58:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qawiwuj5musa" 2025/04/24 03:58:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qawiwuj5musa.bin" 2025/04/24 03:58:37 DEBUG : Swift container crypt path rclone-test-qawiwuj5musa.bin: Auto set use_segments_container to true 2025/04/24 03:58:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qawiwuj5musa" 2025/04/24 03:58:43 DEBUG : Swift container crypt path rclone-test-qawiwuj5musa: Auto set use_segments_container to true 2025/04/24 03:58:49 DEBUG : potato2: md5 = 8fc1f2b29722030d7d229100aab12849 OK 2025/04/24 03:58:54 DEBUG : empty space: md5 = d0fdf369bff181e71e78893f7c7e147d OK 2025/04/24 03:58:59 DEBUG : potato3: md5 = 9e17d1e47927cd86dca04cac83e24024 OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu' -> Encrypted drive 'TestCryptSwift:rclone-test-qawiwuj5musa' 2025/04/24 03:59:10 DEBUG : empty space: md5 = ffc3b4682ca299ddbf5044f96be41c53 OK 2025/04/24 03:59:15 DEBUG : potato3: md5 = a2e263a627889fc7b9d6a3a1363afc1e OK 2025/04/24 03:59:20 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 03:59:20 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/24 03:59:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qawiwuj5musa': Waiting for checks to finish 2025/04/24 03:59:26 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 03:59:26 DEBUG : empty space: Unchanged skipping 2025/04/24 03:59:31 INFO : empty space: Deleted 2025/04/24 03:59:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qawiwuj5musa': Waiting for transfers to finish 2025/04/24 03:59:31 INFO : potato2: Copied (server-side copy) 2025/04/24 03:59:31 INFO : potato2: Deleted 2025/04/24 03:59:36 INFO : potato3: Copied (server-side copy) 2025/04/24 03:59:41 INFO : potato3: Deleted 2025/04/24 03:59:46 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-muvaliv2xiha" 2025/04/24 03:59:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-muvaliv2xiha.bin" 2025/04/24 03:59:47 DEBUG : Swift container crypt path rclone-test-muvaliv2xiha.bin: Auto set use_segments_container to true 2025/04/24 03:59:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-muvaliv2xiha" 2025/04/24 03:59:53 DEBUG : Swift container crypt path rclone-test-muvaliv2xiha: Auto set use_segments_container to true 2025/04/24 03:59:58 DEBUG : empty space: Need to transfer - File not found at Destination 2025/04/24 03:59:58 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 03:59:58 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/24 03:59:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-muvaliv2xiha': Waiting for checks to finish 2025/04/24 03:59:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-muvaliv2xiha': Waiting for transfers to finish 2025/04/24 04:00:04 INFO : potato3: Copied (server-side copy) 2025/04/24 04:00:09 INFO : potato3: Deleted 2025/04/24 04:00:14 INFO : empty space: Copied (server-side copy) 2025/04/24 04:00:14 INFO : empty space: Deleted 2025/04/24 04:00:14 INFO : potato2: Copied (server-side copy) 2025/04/24 04:00:19 INFO : potato2: Deleted 2025/04/24 04:00:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-muvaliv2xiha': Purge remote 2025/04/24 04:00:24 DEBUG : Waiting for deletions to finish 2025/04/24 04:00:25 INFO : potato3.bin: Deleted 2025/04/24 04:00:30 INFO : potato2.bin: Deleted 2025/04/24 04:00:35 INFO : empty space.bin: Deleted 2025/04/24 04:00:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qawiwuj5musa': Purge remote 2025/04/24 04:00:35 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (118.25s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:00:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xidohuj5loki" 2025/04/24 04:00:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xidohuj5loki.bin" 2025/04/24 04:00:36 DEBUG : Swift container crypt path rclone-test-xidohuj5loki.bin: Auto set use_segments_container to true 2025/04/24 04:00:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xidohuj5loki" 2025/04/24 04:00:42 DEBUG : Swift container crypt path rclone-test-xidohuj5loki: Auto set use_segments_container to true 2025/04/24 04:00:47 DEBUG : potato2: md5 = cc241fc7fef41c8fed4c6c9fc36868c6 OK 2025/04/24 04:00:52 DEBUG : empty space: md5 = 75e4a261610a266e9cbbf449b30e6ae9 OK 2025/04/24 04:00:58 DEBUG : potato3: md5 = 79faa1a67096925771dd266c2fb91a9e OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu' -> Encrypted drive 'TestCryptSwift:rclone-test-xidohuj5loki' 2025/04/24 04:01:09 DEBUG : empty space: md5 = fc8ce023ed4a8d63b2759df4a5f2bf1c OK 2025/04/24 04:01:14 DEBUG : potato3: md5 = a3d1c005bd0ffba94ce68e240b90747a OK 2025/04/24 04:01:15 DEBUG : empty space: Excluded (Size Filter) 2025/04/24 04:01:15 DEBUG : empty space: Excluded 2025/04/24 04:01:15 DEBUG : empty space: Excluded (Size Filter) 2025/04/24 04:01:15 DEBUG : empty space: Excluded 2025/04/24 04:01:15 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 04:01:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xidohuj5loki': Waiting for checks to finish 2025/04/24 04:01:15 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/24 04:01:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xidohuj5loki': Waiting for transfers to finish 2025/04/24 04:01:20 INFO : potato2: Copied (server-side copy) 2025/04/24 04:01:20 INFO : potato2: Deleted 2025/04/24 04:01:30 INFO : potato3: Copied (server-side copy) 2025/04/24 04:01:35 INFO : potato3: Deleted 2025/04/24 04:01:41 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-macexuf5rase" 2025/04/24 04:01:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-macexuf5rase.bin" 2025/04/24 04:01:41 DEBUG : Swift container crypt path rclone-test-macexuf5rase.bin: Auto set use_segments_container to true 2025/04/24 04:01:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-macexuf5rase" 2025/04/24 04:01:47 DEBUG : Swift container crypt path rclone-test-macexuf5rase: Auto set use_segments_container to true 2025/04/24 04:01:53 DEBUG : empty space: Excluded (Size Filter) 2025/04/24 04:01:53 DEBUG : empty space: Excluded 2025/04/24 04:01:53 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 04:01:53 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/24 04:01:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-macexuf5rase': Waiting for checks to finish 2025/04/24 04:01:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-macexuf5rase': Waiting for transfers to finish 2025/04/24 04:02:03 INFO : potato3: Copied (server-side copy) 2025/04/24 04:02:03 INFO : potato2: Copied (server-side copy) 2025/04/24 04:02:04 INFO : potato2: Deleted 2025/04/24 04:02:08 INFO : potato3: Deleted 2025/04/24 04:02:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-macexuf5rase': Purge remote 2025/04/24 04:02:14 DEBUG : Waiting for deletions to finish 2025/04/24 04:02:24 INFO : potato3.bin: Deleted 2025/04/24 04:02:24 INFO : potato2.bin: Deleted 2025/04/24 04:02:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xidohuj5loki': Purge remote 2025/04/24 04:02:24 DEBUG : Waiting for deletions to finish 2025/04/24 04:02:35 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (130.16s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:02:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-vicatol1lafe" 2025/04/24 04:02:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-vicatol1lafe.bin" 2025/04/24 04:02:46 DEBUG : Swift container crypt path rclone-test-vicatol1lafe.bin: Auto set use_segments_container to true 2025/04/24 04:02:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-vicatol1lafe" 2025/04/24 04:02:52 DEBUG : Swift container crypt path rclone-test-vicatol1lafe: Auto set use_segments_container to true 2025/04/24 04:02:57 DEBUG : potato2: md5 = 1ce602d7a2c768adc6c745670db60995 OK 2025/04/24 04:03:02 DEBUG : empty space: md5 = e82677c6cfa9ecb413b35b9a8e303bd6 OK 2025/04/24 04:03:07 DEBUG : potato3: md5 = d5da8abece1cdc951e546ba340e081eb OK 2025/04/24 04:03:07 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu' -> Encrypted drive 'TestCryptSwift:rclone-test-vicatol1lafe' 2025/04/24 04:03:23 DEBUG : empty space: md5 = cdf8b56c88186cde12566e804f276be3 OK 2025/04/24 04:03:28 DEBUG : potato3: md5 = ba541604bd5677be7473bbd9480d4816 OK 2025/04/24 04:03:29 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 04:03:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vicatol1lafe': Waiting for checks to finish 2025/04/24 04:03:29 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/04/24 04:03:29 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:03:29 DEBUG : empty space: Unchanged skipping 2025/04/24 04:03:34 INFO : empty space: Deleted 2025/04/24 04:03:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vicatol1lafe': Waiting for transfers to finish 2025/04/24 04:03:34 INFO : potato2: Copied (server-side copy) 2025/04/24 04:03:34 INFO : potato2: Deleted 2025/04/24 04:03:39 INFO : potato3: Copied (server-side copy) 2025/04/24 04:03:44 INFO : potato3: Deleted 2025/04/24 04:03:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xilebiv5repe" 2025/04/24 04:03:50 DEBUG : Config file has changed externally - reloading 2025/04/24 04:03:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xilebiv5repe.bin" 2025/04/24 04:03:50 DEBUG : Swift container crypt path rclone-test-xilebiv5repe.bin: Auto set use_segments_container to true 2025/04/24 04:03:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xilebiv5repe" 2025/04/24 04:03:56 DEBUG : Swift container crypt path rclone-test-xilebiv5repe: Auto set use_segments_container to true 2025/04/24 04:04:02 INFO : tomatoDir: Making directory 2025/04/24 04:04:02 DEBUG : empty space: Need to transfer - File not found at Destination 2025/04/24 04:04:02 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/24 04:04:02 DEBUG : potato3: Need to transfer - File not found at Destination 2025/04/24 04:04:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xilebiv5repe': Waiting for checks to finish 2025/04/24 04:04:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xilebiv5repe': Waiting for transfers to finish 2025/04/24 04:04:08 INFO : potato2: Copied (server-side copy) 2025/04/24 04:04:08 INFO : potato3: Copied (server-side copy) 2025/04/24 04:04:08 INFO : potato2: Deleted 2025/04/24 04:04:13 INFO : empty space: Copied (server-side copy) 2025/04/24 04:04:13 INFO : potato3: Deleted 2025/04/24 04:04:18 INFO : empty space: Deleted 2025/04/24 04:04:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xilebiv5repe': Purge remote 2025/04/24 04:04:23 DEBUG : Waiting for deletions to finish 2025/04/24 04:04:23 INFO : potato2.bin: Deleted 2025/04/24 04:04:23 INFO : potato3.bin: Deleted 2025/04/24 04:04:28 INFO : empty space.bin: Deleted 2025/04/24 04:04:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vicatol1lafe': Purge remote 2025/04/24 04:04:28 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (103.58s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:04:29 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-move-test" 2025/04/24 04:04:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-move-test.bin" 2025/04/24 04:04:29 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-move-test.bin: Auto set use_segments_container to true 2025/04/24 04:04:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-move-test" 2025/04/24 04:04:35 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-move-test: Auto set use_segments_container to true 2025/04/24 04:04:41 DEBUG : potato2: md5 = 6bbf005a3fb3b39dfa5ed9c12f8afe3b OK --- PASS: TestServerSideMoveOverlap (12.56s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:04:41 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test" 2025/04/24 04:04:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-sync-test.bin" 2025/04/24 04:04:42 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-sync-test.bin: Auto set use_segments_container to true 2025/04/24 04:04:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-sync-test" 2025/04/24 04:04:48 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncOverlap (12.76s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:04:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test" 2025/04/24 04:04:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-sync-test.bin" 2025/04/24 04:04:55 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-sync-test.bin: Auto set use_segments_container to true 2025/04/24 04:05:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-sync-test" 2025/04/24 04:05:00 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-sync-test: Auto set use_segments_container to true 2025/04/24 04:05:06 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test-include/layer2" 2025/04/24 04:05:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-sync-test-include/layer2.bin" 2025/04/24 04:05:06 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/04/24 04:05:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-sync-test-include/layer2" 2025/04/24 04:05:12 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/04/24 04:05:17 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test-ignore-file" 2025/04/24 04:05:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-sync-test-ignore-file.bin" 2025/04/24 04:05:18 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/04/24 04:05:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/rclone-sync-test-ignore-file" 2025/04/24 04:05:24 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/04/24 04:05:35 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = f8dff1a0fb1f185d65b6e14b64627767 OK 2025/04/24 04:05:45 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/24 04:05:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test': Waiting for checks to finish 2025/04/24 04:05:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test': Waiting for transfers to finish 2025/04/24 04:05:45 DEBUG : Waiting for deletions to finish 2025/04/24 04:05:45 INFO : There was nothing to transfer 2025/04/24 04:05:55 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/24 04:05:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 04:05:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 04:05:55 DEBUG : Waiting for deletions to finish 2025/04/24 04:05:55 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:06:05 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/24 04:06:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/04/24 04:06:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/04/24 04:06:05 DEBUG : Waiting for deletions to finish 2025/04/24 04:06:05 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:06:11 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/24 04:06:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 04:06:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 04:06:11 DEBUG : Waiting for deletions to finish 2025/04/24 04:06:11 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:06:11 DEBUG : : Excluded 2025/04/24 04:06:11 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/04/24 04:06:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/04/24 04:06:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/04/24 04:06:11 DEBUG : Waiting for deletions to finish 2025/04/24 04:06:11 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (90.41s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:06:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:06:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst.bin" 2025/04/24 04:06:25 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst.bin: Auto set use_segments_container to true 2025/04/24 04:06:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:06:31 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst: Auto set use_segments_container to true 2025/04/24 04:06:36 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/CompareDest" 2025/04/24 04:06:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/CompareDest.bin" 2025/04/24 04:06:37 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/CompareDest.bin: Auto set use_segments_container to true 2025/04/24 04:06:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/CompareDest" 2025/04/24 04:06:43 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/CompareDest: Auto set use_segments_container to true 2025/04/24 04:06:53 DEBUG : one: Need to transfer - File not found at Destination 2025/04/24 04:06:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:06:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:06:54 DEBUG : one: md5 = 40e5878813569a135a0d8eb3a3e50b00 OK 2025/04/24 04:06:54 INFO : one: Copied (new) 2025/04/24 04:06:54 DEBUG : Waiting for deletions to finish 2025/04/24 04:06:54 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/24 04:06:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:06:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:06:59 DEBUG : one: md5 = 13cd0e6e0b794c76c08ed3e584ba7bd6 OK 2025/04/24 04:06:59 INFO : one: Copied (replaced existing) 2025/04/24 04:06:59 DEBUG : Waiting for deletions to finish 2025/04/24 04:07:00 DEBUG : dst/one: md5 = e38ff8f89e97f5e9790d016c2afe0b57 OK 2025/04/24 04:07:05 DEBUG : CompareDest/one: md5 = d9a7aef0187308492c995f183c46a8ac OK 2025/04/24 04:07:05 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/24 04:07:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:07:05 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:07:05 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/24 04:07:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:07:05 DEBUG : Waiting for deletions to finish 2025/04/24 04:07:05 INFO : There was nothing to transfer 2025/04/24 04:07:06 DEBUG : CompareDest/two: md5 = b260d7742b0c27d580d74221c78c5d4e OK 2025/04/24 04:07:06 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/24 04:07:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:07:06 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/24 04:07:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:07:11 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:07:11 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/24 04:07:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:07:11 DEBUG : Waiting for deletions to finish 2025/04/24 04:07:11 INFO : There was nothing to transfer 2025/04/24 04:07:17 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/24 04:07:17 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:07:17 DEBUG : two: Destination found in --compare-dest, skipping 2025/04/24 04:07:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:07:17 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:07:17 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/24 04:07:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:07:17 DEBUG : Waiting for deletions to finish 2025/04/24 04:07:17 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2025/04/24 04:07:17 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/24 04:07:17 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:07:17 DEBUG : one: Destination found in --compare-dest, skipping 2025/04/24 04:07:17 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/04/24 04:07:17 DEBUG : two: Need to transfer - File not found at Destination 2025/04/24 04:07:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:07:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:07:23 DEBUG : two: md5 = 268716d5a6375b05396478a91f5d9849 OK 2025/04/24 04:07:23 INFO : two: Copied (new) 2025/04/24 04:07:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (79.25s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:07:49 DEBUG : pre-dest1/1: md5 = a69c60e6b052d784871239c6be5c5666 OK 2025/04/24 04:07:50 DEBUG : pre-dest2/2: md5 = 6d9c929109dbf55a86bcdb12614bd5c0 OK 2025/04/24 04:07:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/dest" 2025/04/24 04:07:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dest.bin" 2025/04/24 04:07:50 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dest.bin: Auto set use_segments_container to true 2025/04/24 04:07:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dest" 2025/04/24 04:07:56 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dest: Auto set use_segments_container to true 2025/04/24 04:08:02 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/pre-dest1" 2025/04/24 04:08:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/pre-dest1.bin" 2025/04/24 04:08:02 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/pre-dest1.bin: Auto set use_segments_container to true 2025/04/24 04:08:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/pre-dest1" 2025/04/24 04:08:08 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/pre-dest1: Auto set use_segments_container to true 2025/04/24 04:08:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/pre-dest2" 2025/04/24 04:08:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/pre-dest2.bin" 2025/04/24 04:08:14 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/pre-dest2.bin: Auto set use_segments_container to true 2025/04/24 04:08:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/pre-dest2" 2025/04/24 04:08:20 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/pre-dest2: Auto set use_segments_container to true 2025/04/24 04:08:26 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:08:26 DEBUG : 1: Destination found in --compare-dest, skipping 2025/04/24 04:08:31 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:08:31 DEBUG : 2: Destination found in --compare-dest, skipping 2025/04/24 04:08:41 DEBUG : 3: Need to transfer - File not found at Destination 2025/04/24 04:08:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dest': Waiting for checks to finish 2025/04/24 04:08:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dest': Waiting for transfers to finish 2025/04/24 04:08:47 DEBUG : 3: md5 = 367e857ddcca29ceac3b71445c9f09b8 OK 2025/04/24 04:08:47 INFO : 3: Copied (new) 2025/04/24 04:08:47 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (84.17s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:09:08 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:09:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst.bin" 2025/04/24 04:09:09 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst.bin: Auto set use_segments_container to true 2025/04/24 04:09:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:09:14 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst: Auto set use_segments_container to true 2025/04/24 04:09:19 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/CopyDest" 2025/04/24 04:09:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/CopyDest.bin" 2025/04/24 04:09:20 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/CopyDest.bin: Auto set use_segments_container to true 2025/04/24 04:09:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/CopyDest" 2025/04/24 04:09:26 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/CopyDest: Auto set use_segments_container to true 2025/04/24 04:09:36 DEBUG : one: Need to transfer - File not found at Destination 2025/04/24 04:09:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:09:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:09:37 DEBUG : one: md5 = 3fff7b6c5c732bcece323f0334c042d7 OK 2025/04/24 04:09:37 INFO : one: Copied (new) 2025/04/24 04:09:37 DEBUG : Waiting for deletions to finish 2025/04/24 04:09:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:09:37 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/24 04:09:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:09:42 DEBUG : one: md5 = 294393a67c4e901efccdea0ecf96ba62 OK 2025/04/24 04:09:42 INFO : one: Copied (replaced existing) 2025/04/24 04:09:42 DEBUG : Waiting for deletions to finish 2025/04/24 04:09:43 DEBUG : dst/one: md5 = 4ee1fae95c6bb0dc55db207393e7cb1d OK 2025/04/24 04:09:48 DEBUG : CopyDest/one: md5 = 583202e7947d160216188244523cbedc OK 2025/04/24 04:09:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/BackupDir" 2025/04/24 04:09:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/BackupDir.bin" 2025/04/24 04:09:49 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/BackupDir.bin: Auto set use_segments_container to true 2025/04/24 04:09:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/BackupDir" 2025/04/24 04:09:55 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/BackupDir: Auto set use_segments_container to true 2025/04/24 04:10:00 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/24 04:10:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:10:05 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:10:05 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/04/24 04:10:16 INFO : one: Copied (server-side copy) 2025/04/24 04:10:16 INFO : one: Deleted 2025/04/24 04:10:22 INFO : one: Copied (server-side copy) 2025/04/24 04:10:22 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/04/24 04:10:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:10:22 DEBUG : Waiting for deletions to finish 2025/04/24 04:10:27 DEBUG : CopyDest/two: md5 = 9d43d150cac275e4c25fda432319e6f7 OK 2025/04/24 04:10:33 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:10:33 DEBUG : one: Unchanged skipping 2025/04/24 04:10:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:10:48 INFO : two: Copied (server-side copy) 2025/04/24 04:10:48 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/04/24 04:10:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:10:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:10:48 DEBUG : Waiting for deletions to finish 2025/04/24 04:10:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:10:53 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:10:53 DEBUG : one: Unchanged skipping 2025/04/24 04:10:53 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:10:53 DEBUG : two: Unchanged skipping 2025/04/24 04:10:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:10:53 DEBUG : Waiting for deletions to finish 2025/04/24 04:10:53 INFO : There was nothing to transfer 2025/04/24 04:10:59 DEBUG : CopyDest/three: md5 = 31014361739934cfee4de8e0251082f8 OK 2025/04/24 04:11:05 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:11:05 DEBUG : one: Unchanged skipping 2025/04/24 04:11:10 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/04/24 04:11:10 DEBUG : three: Destination not found in --copy-dest 2025/04/24 04:11:10 DEBUG : three: Need to transfer - File not found at Destination 2025/04/24 04:11:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:11:10 DEBUG : three: md5 = b8abade7808323bfd4912680aa2ca2e5 OK 2025/04/24 04:11:10 INFO : three: Copied (new) 2025/04/24 04:11:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:11:15 DEBUG : two: Unchanged skipping 2025/04/24 04:11:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:11:15 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (168.95s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:11:57 DEBUG : dst/one: md5 = 5a053a48f3a9bbe31d430024307947a0 OK 2025/04/24 04:12:02 DEBUG : dst/two: md5 = 94d10ba1504993f307da1b0f4ddd58b3 OK 2025/04/24 04:12:02 DEBUG : dst/three.txt: md5 = acffcd185f2dc445d1658975280e6049 OK 2025/04/24 04:12:08 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:12:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst.bin" 2025/04/24 04:12:08 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst.bin: Auto set use_segments_container to true 2025/04/24 04:12:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:12:14 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst: Auto set use_segments_container to true 2025/04/24 04:12:19 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/backup" 2025/04/24 04:12:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/backup.bin" 2025/04/24 04:12:20 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/backup.bin: Auto set use_segments_container to true 2025/04/24 04:12:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/backup" 2025/04/24 04:12:26 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/backup: Auto set use_segments_container to true 2025/04/24 04:12:31 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/24 04:12:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:12:36 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:12:36 DEBUG : two: Unchanged skipping 2025/04/24 04:12:42 INFO : one: Copied (server-side copy) 2025/04/24 04:12:42 INFO : one: Deleted 2025/04/24 04:12:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:12:42 DEBUG : one: md5 = 2057e62af3b0f6bec1164465d6884b65 OK 2025/04/24 04:12:42 INFO : one: Copied (new) 2025/04/24 04:12:42 DEBUG : Waiting for deletions to finish 2025/04/24 04:12:58 INFO : three.txt: Copied (server-side copy) 2025/04/24 04:12:58 INFO : three.txt: Deleted 2025/04/24 04:12:58 INFO : three.txt: Moved into backup dir 2025/04/24 04:13:03 DEBUG : dst/three.txt: md5 = 4d6e1d2393e2c84fa9e0d85a575502dd OK 2025/04/24 04:13:04 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/24 04:13:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:13:09 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:13:09 DEBUG : two: Unchanged skipping 2025/04/24 04:13:09 INFO : one: Copied (server-side copy) 2025/04/24 04:13:09 INFO : one: Deleted 2025/04/24 04:13:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:13:09 DEBUG : one: md5 = 8595243924eac9a54d783ceccc40a257 OK 2025/04/24 04:13:09 INFO : one: Copied (new) 2025/04/24 04:13:09 DEBUG : Waiting for deletions to finish 2025/04/24 04:13:25 INFO : three.txt: Copied (server-side copy) 2025/04/24 04:13:25 INFO : three.txt: Deleted 2025/04/24 04:13:25 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (104.29s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:13:41 DEBUG : dst/one: md5 = 00ae88d4a288464833744665e6b37ae9 OK 2025/04/24 04:13:47 DEBUG : dst/two: md5 = 5aa00a88969fa90c2259c5bc9e0fa2c1 OK 2025/04/24 04:13:47 DEBUG : dst/three.txt: md5 = f752a462529f74968e7b3930706445cd OK 2025/04/24 04:13:52 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:13:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst.bin" 2025/04/24 04:13:53 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst.bin: Auto set use_segments_container to true 2025/04/24 04:13:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:13:58 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst: Auto set use_segments_container to true 2025/04/24 04:14:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/backup" 2025/04/24 04:14:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/backup.bin" 2025/04/24 04:14:04 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/backup.bin: Auto set use_segments_container to true 2025/04/24 04:14:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/backup" 2025/04/24 04:14:10 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/backup: Auto set use_segments_container to true 2025/04/24 04:14:15 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/24 04:14:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:14:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:14:15 DEBUG : two: Unchanged skipping 2025/04/24 04:14:26 INFO : one: Copied (server-side copy) to: one.bak 2025/04/24 04:14:26 INFO : one: Deleted 2025/04/24 04:14:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:14:27 DEBUG : one: md5 = 105ac6ae1c7e6ac15742946042be4392 OK 2025/04/24 04:14:27 INFO : one: Copied (new) 2025/04/24 04:14:27 DEBUG : Waiting for deletions to finish 2025/04/24 04:14:47 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/24 04:14:47 INFO : three.txt: Deleted 2025/04/24 04:14:47 INFO : three.txt: Moved into backup dir 2025/04/24 04:14:53 DEBUG : dst/three.txt: md5 = 93052b4aa6f3d4525c387efafa0ccdc8 OK 2025/04/24 04:14:58 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/24 04:14:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:14:58 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:14:58 DEBUG : two: Unchanged skipping 2025/04/24 04:15:04 INFO : one: Copied (server-side copy) to: one.bak 2025/04/24 04:15:04 INFO : one: Deleted 2025/04/24 04:15:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:15:04 DEBUG : one: md5 = 892e397ec39d573eb0f262d2674e22cd OK 2025/04/24 04:15:04 INFO : one: Copied (new) 2025/04/24 04:15:04 DEBUG : Waiting for deletions to finish 2025/04/24 04:15:14 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/24 04:15:14 INFO : three.txt: Deleted 2025/04/24 04:15:14 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (114.40s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:15:36 DEBUG : dst/one: md5 = bdb5021d1f933537115dc8f099012e33 OK 2025/04/24 04:15:42 DEBUG : dst/two: md5 = 56c66a675bc9abcc871e53b8100cdb67 OK 2025/04/24 04:15:42 DEBUG : dst/three.txt: md5 = 09a1325b3c2c69f39396fda4cda21361 OK 2025/04/24 04:15:47 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:15:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst.bin" 2025/04/24 04:15:48 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst.bin: Auto set use_segments_container to true 2025/04/24 04:15:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:15:53 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst: Auto set use_segments_container to true 2025/04/24 04:15:59 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/backup" 2025/04/24 04:15:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/backup.bin" 2025/04/24 04:15:59 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/backup.bin: Auto set use_segments_container to true 2025/04/24 04:16:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/backup" 2025/04/24 04:16:05 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/backup: Auto set use_segments_container to true 2025/04/24 04:16:10 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/24 04:16:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:16:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:16:10 DEBUG : two: Unchanged skipping 2025/04/24 04:16:38 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/24 04:16:38 INFO : one: Deleted 2025/04/24 04:16:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:16:38 DEBUG : one: md5 = d9fbb858d9764237b7ad633d838e9d44 OK 2025/04/24 04:16:38 INFO : one: Copied (new) 2025/04/24 04:16:38 DEBUG : Waiting for deletions to finish 2025/04/24 04:16:49 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/24 04:16:49 INFO : three.txt: Deleted 2025/04/24 04:16:49 INFO : three.txt: Moved into backup dir 2025/04/24 04:16:55 DEBUG : dst/three.txt: md5 = eafebd2e1f817e66de8a817777c1efb2 OK 2025/04/24 04:17:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:17:00 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/24 04:17:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:17:00 DEBUG : two: Unchanged skipping 2025/04/24 04:17:16 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/24 04:17:16 INFO : one: Deleted 2025/04/24 04:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:17:16 DEBUG : one: md5 = 489feff49d12bfdef52764704e1c4fd9 OK 2025/04/24 04:17:16 INFO : one: Copied (new) 2025/04/24 04:17:16 DEBUG : Waiting for deletions to finish 2025/04/24 04:17:22 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/24 04:17:22 INFO : three.txt: Deleted 2025/04/24 04:17:22 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (122.07s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:17:38 DEBUG : dst/one: md5 = 2fc105bedb04eda03ea9a8dd5ed2fe60 OK 2025/04/24 04:17:43 DEBUG : dst/two: md5 = 9e1ceacae71e2b60ad3e7b4e1615b165 OK 2025/04/24 04:17:43 DEBUG : dst/three.txt: md5 = 22d141794bb03c2a29aa1b322c001212 OK 2025/04/24 04:17:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:17:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst.bin" 2025/04/24 04:17:44 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst.bin: Auto set use_segments_container to true 2025/04/24 04:17:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:17:50 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst: Auto set use_segments_container to true 2025/04/24 04:17:55 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/24 04:17:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:18:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:18:00 DEBUG : two: Unchanged skipping 2025/04/24 04:18:11 INFO : one: Copied (server-side copy) to: one.bak 2025/04/24 04:18:11 INFO : one: Deleted 2025/04/24 04:18:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:18:11 DEBUG : one: md5 = c326a2238b6ca89f7e0fb7b4189ab279 OK 2025/04/24 04:18:11 INFO : one: Copied (new) 2025/04/24 04:18:11 DEBUG : Waiting for deletions to finish 2025/04/24 04:18:32 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/24 04:18:32 INFO : three.txt: Deleted 2025/04/24 04:18:32 INFO : three.txt: Moved into backup dir 2025/04/24 04:18:38 DEBUG : dst/three.txt: md5 = 6ae0cf94923324d042e194841c1c6659 OK 2025/04/24 04:18:38 DEBUG : one.bak: Excluded (Path Filter) 2025/04/24 04:18:38 DEBUG : one.bak: Excluded 2025/04/24 04:18:38 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/04/24 04:18:38 DEBUG : three.txt.bak: Excluded 2025/04/24 04:18:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for checks to finish 2025/04/24 04:18:38 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/24 04:18:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:18:38 DEBUG : two: Unchanged skipping 2025/04/24 04:18:54 INFO : one: Copied (server-side copy) to: one.bak 2025/04/24 04:18:54 INFO : one: Deleted 2025/04/24 04:18:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu/dst': Waiting for transfers to finish 2025/04/24 04:18:54 DEBUG : one: md5 = d00d02d6df6e429022efe09cbb1fb5fe OK 2025/04/24 04:18:54 INFO : one: Copied (new) 2025/04/24 04:18:54 DEBUG : Waiting for deletions to finish 2025/04/24 04:19:09 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/24 04:19:09 INFO : three.txt: Deleted 2025/04/24 04:19:09 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (117.79s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:19:36 DEBUG : dst/one: md5 = 90e86213e6c4d77bd2e91c4c02fc0939 OK 2025/04/24 04:19:41 DEBUG : dst/two: md5 = 08b37a66f3ea31039449cd8301cf12a8 OK 2025/04/24 04:19:41 DEBUG : dst/three.txt: md5 = 2e79cb84c66bba44fb45f1b82e86d4a0 OK 2025/04/24 04:19:41 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:19:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst.bin" 2025/04/24 04:19:42 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst.bin: Auto set use_segments_container to true 2025/04/24 04:19:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:19:47 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst: Auto set use_segments_container to true 2025/04/24 04:19:53 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/24 04:20:13 INFO : one: Copied (server-side copy) to: one.bak 2025/04/24 04:20:13 INFO : one: Deleted 2025/04/24 04:20:13 DEBUG : one: md5 = 69a69d5918df4b8f76be989c043fbe9b OK 2025/04/24 04:20:13 INFO : one: Copied (new) 2025/04/24 04:20:13 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:20:13 DEBUG : two: Unchanged skipping 2025/04/24 04:20:13 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/24 04:20:29 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/24 04:20:29 INFO : three.txt: Deleted 2025/04/24 04:20:29 DEBUG : three.txt: md5 = fcd51f292b3f0ee808c3a4c4c54af281 OK 2025/04/24 04:20:29 INFO : three.txt: Copied (new) 2025/04/24 04:20:45 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/24 04:21:01 INFO : one: Copied (server-side copy) to: one.bak 2025/04/24 04:21:01 INFO : one: Deleted 2025/04/24 04:21:01 DEBUG : one: md5 = b47bda07dd786f417b737cfeff124dcb OK 2025/04/24 04:21:01 INFO : one: Copied (new) 2025/04/24 04:21:01 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:21:01 DEBUG : two: Unchanged skipping 2025/04/24 04:21:01 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/04/24 04:21:13 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/04/24 04:21:14 INFO : three.txt: Deleted 2025/04/24 04:21:14 DEBUG : three.txt: md5 = b34c313e5c2ec29f944330f75b89d28a OK 2025/04/24 04:21:14 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (129.64s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:21:45 DEBUG : dst/one: md5 = cd29b94074b5f7c299d44b96d5fc2b5b OK 2025/04/24 04:21:51 DEBUG : dst/two: md5 = 4fde8637ccd9ab07233500c66894b2bd OK 2025/04/24 04:21:51 DEBUG : dst/three.txt: md5 = e662820f55660032f0d76ee996ca5f94 OK 2025/04/24 04:21:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:21:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst.bin" 2025/04/24 04:21:52 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst.bin: Auto set use_segments_container to true 2025/04/24 04:21:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiwoviq3gofu/dst" 2025/04/24 04:21:58 DEBUG : Swift container crypt path rclone-test-wiwoviq3gofu/dst: Auto set use_segments_container to true 2025/04/24 04:22:03 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/24 04:22:19 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/24 04:22:19 INFO : one: Deleted 2025/04/24 04:22:20 DEBUG : one: md5 = baffb1b945308c990e3a2bf2fceb6d5a OK 2025/04/24 04:22:20 INFO : one: Copied (new) 2025/04/24 04:22:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:22:20 DEBUG : two: Unchanged skipping 2025/04/24 04:22:20 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/24 04:22:35 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/24 04:22:35 INFO : three.txt: Deleted 2025/04/24 04:22:35 DEBUG : three.txt: md5 = 85c09c18965d36bb9fb435910819ce19 OK 2025/04/24 04:22:35 INFO : three.txt: Copied (new) 2025/04/24 04:22:47 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/24 04:23:02 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/04/24 04:23:02 INFO : one: Deleted 2025/04/24 04:23:02 DEBUG : one: md5 = 6adcc2b195bda25cfd1e3e6460abba63 OK 2025/04/24 04:23:02 INFO : one: Copied (new) 2025/04/24 04:23:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:23:07 DEBUG : two: Unchanged skipping 2025/04/24 04:23:07 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/04/24 04:23:23 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/04/24 04:23:23 INFO : three.txt: Deleted 2025/04/24 04:23:23 DEBUG : three.txt: md5 = 46f127f7d0427072a02584cb78843f12 OK 2025/04/24 04:23:23 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (129.60s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:23:55 DEBUG : Testêé: md5 = ff33a9cfb72b895e26ad5d8ff5cfbe50 OK 2025/04/24 04:23:55 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/04/24 04:23:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 04:23:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 04:23:56 DEBUG : Testêé: md5 = 97e66b7284ae33e43689023d50f979b8 OK 2025/04/24 04:23:56 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/04/24 04:23:56 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (2.02s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:23:57 DEBUG : existing: Need to transfer - File not found at Destination 2025/04/24 04:23:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 04:23:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 04:24:02 DEBUG : existing: md5 = a4c42bfb89b13d2422ca8df40efc9fa0 OK 2025/04/24 04:24:02 INFO : existing: Copied (new) 2025/04/24 04:24:02 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:24:08 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/04/24 04:24:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 04:24:13 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/04/24 04:24:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 04:24:13 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': not deleting files as there were IO errors 2025/04/24 04:24:13 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncImmutable (21.71s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:24:19 DEBUG : EXISTING: md5 = 45fd215db4e7199be2122724d8690907 OK 2025/04/24 04:24:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 04:24:19 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:24:19 DEBUG : existing: Unchanged skipping 2025/04/24 04:24:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 04:24:19 DEBUG : Waiting for deletions to finish 2025/04/24 04:24:19 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.14s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.31s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", 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-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", 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-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.29s) --- SKIP: TestMaxTransfer/Hard (0.10s) --- SKIP: TestMaxTransfer/Soft (0.10s) --- SKIP: TestMaxTransfer/Cautious (0.10s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:24:21 DEBUG : both0: md5 = 72c769fe63a19455ef688c3d4e1198b7 OK 2025/04/24 04:24:21 DEBUG : only0: md5 = 04b87f8ccd09ee98ba6f4d0d606489fe OK 2025/04/24 04:24:26 DEBUG : both1: md5 = 8d0063c51d02ddc3a17747404851776e OK 2025/04/24 04:24:31 DEBUG : only1: md5 = 7e19392568f2e13b064bf9be1144b5ea OK 2025/04/24 04:24:37 DEBUG : both2: md5 = fd2b76843d35b181b230732016a97fb1 OK 2025/04/24 04:24:37 DEBUG : only2: md5 = b20edfa302259f3e5ae52e3b467ea17d OK 2025/04/24 04:24:42 DEBUG : both3: md5 = d700b565ae6cc7bfa194078a5680daca OK 2025/04/24 04:24:43 DEBUG : only3: md5 = 4d36c81f92dd9de4101a24e83c2881ba OK 2025/04/24 04:24:43 DEBUG : both4: md5 = 844c113734b615972ae943f7f83b50d1 OK 2025/04/24 04:24:44 DEBUG : only4: md5 = 17f557211c1571fbaa42488d61c7ecaa OK 2025/04/24 04:24:44 DEBUG : both5: md5 = 42421b82b33d75fde2fa506355126f86 OK 2025/04/24 04:24:44 DEBUG : only5: md5 = a2ccea41257a2d755fe88beb494abac6 OK 2025/04/24 04:24:50 DEBUG : both6: md5 = a567343ebfc6f630f76f6fd1c25671cc OK 2025/04/24 04:24:50 DEBUG : only6: md5 = c3ab1acafa6d9ce4e556d5998595ecf4 OK 2025/04/24 04:24:51 DEBUG : both7: md5 = 7eeae62a4c0df2ea2d67905e9f55eb2c OK 2025/04/24 04:24:56 DEBUG : only7: md5 = 57693a251413a53de76066e877c772b2 OK 2025/04/24 04:25:01 DEBUG : both8: md5 = 5fb48b13d0797c61796b3caecd09f4ac OK 2025/04/24 04:25:07 DEBUG : only8: md5 = beb17830417450b9e3636a2508aa5ced OK 2025/04/24 04:25:12 DEBUG : both9: md5 = ada668e2e6f7e1458d9715047ce57956 OK 2025/04/24 04:25:18 DEBUG : only9: md5 = d58f2765dd2bf997b11194c0a6afb860 OK 2025/04/24 04:25:23 DEBUG : both10: md5 = 12439e97a0a2b667c38c7df23fcef874 OK 2025/04/24 04:25:24 DEBUG : only10: md5 = 18998788deb541f34d0b9baa2e511416 OK 2025/04/24 04:25:29 DEBUG : both11: md5 = 901cf2eaa5bf471ac2e655ad087a50b7 OK 2025/04/24 04:25:29 DEBUG : only11: md5 = ca4dc71affa8fd164150221a55a3916f OK 2025/04/24 04:25:35 DEBUG : both12: md5 = dc398b4daa2ca6bc9557b2e1c0085ceb OK 2025/04/24 04:25:40 DEBUG : only12: md5 = bfc35135ad682ea54940e591e054e783 OK 2025/04/24 04:25:46 DEBUG : both13: md5 = 78b6db64153e06ec025b152b1a8222ff OK 2025/04/24 04:25:51 DEBUG : only13: md5 = 8fd8d24f3966566f05968bb5760f9f13 OK 2025/04/24 04:25:57 DEBUG : both14: md5 = 8c8912bbba12731d46512bb152830c86 OK 2025/04/24 04:26:02 DEBUG : only14: md5 = 4403fcbadde4ac8ab9a5421a0584aa81 OK 2025/04/24 04:26:07 DEBUG : both15: md5 = e2980cf1081c4d99c313363329526805 OK 2025/04/24 04:26:08 DEBUG : only15: md5 = 790fc99e66a0eac20ee69775b7288dd2 OK 2025/04/24 04:26:14 DEBUG : both16: md5 = 9c70bb57c50fc65f66150c2652c60738 OK 2025/04/24 04:26:14 DEBUG : only16: md5 = a951e350f9b72e16bf853eba7203a549 OK 2025/04/24 04:26:19 DEBUG : both17: md5 = d437e4766f6cf6ab5066fc5d0f8d9d05 OK 2025/04/24 04:26:19 DEBUG : only17: md5 = c5650730e3510190a592966018a68dc1 OK 2025/04/24 04:26:25 DEBUG : both18: md5 = 1b204d855a6ba2daade6d07b5220e280 OK 2025/04/24 04:26:25 DEBUG : only18: md5 = 6b0ff083c8f43212983931bbf905beec OK 2025/04/24 04:26:30 DEBUG : both19: md5 = a015b0deb9a3515b82443d645e08c308 OK 2025/04/24 04:26:36 DEBUG : only19: md5 = c60f3e8a62f8d9abef10a938a63952bb OK 2025/04/24 04:26:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 04:26:58 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:26:58 DEBUG : both0: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both10: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both1: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both11: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both12: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both14: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both15: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both16: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both18: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both19: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both3: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both4: Unchanged skipping 2025/04/24 04:27:03 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:03 DEBUG : both5: Unchanged skipping 2025/04/24 04:27:08 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:08 DEBUG : both13: Unchanged skipping 2025/04/24 04:27:08 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:08 DEBUG : both7: Unchanged skipping 2025/04/24 04:27:08 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:08 DEBUG : both17: Unchanged skipping 2025/04/24 04:27:08 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:08 DEBUG : both2: Unchanged skipping 2025/04/24 04:27:08 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:08 DEBUG : both9: Unchanged skipping 2025/04/24 04:27:08 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:08 DEBUG : both6: Unchanged skipping 2025/04/24 04:27:13 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:27:13 DEBUG : both8: Unchanged skipping 2025/04/24 04:27:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 04:27:13 DEBUG : Waiting for deletions to finish 2025/04/24 04:27:13 INFO : only3: Deleted 2025/04/24 04:27:13 INFO : only18: Deleted 2025/04/24 04:27:13 INFO : only10: Deleted 2025/04/24 04:27:18 INFO : only13: Deleted 2025/04/24 04:27:18 INFO : only16: Deleted 2025/04/24 04:27:18 INFO : only7: Deleted 2025/04/24 04:27:18 INFO : only6: Deleted 2025/04/24 04:27:19 INFO : only5: Deleted 2025/04/24 04:27:19 INFO : only11: Deleted 2025/04/24 04:27:24 INFO : only9: Deleted 2025/04/24 04:27:24 INFO : only12: Deleted 2025/04/24 04:27:24 INFO : only8: Deleted 2025/04/24 04:27:24 INFO : only2: Deleted 2025/04/24 04:27:24 INFO : only15: Deleted 2025/04/24 04:27:24 INFO : only4: Deleted 2025/04/24 04:27:24 INFO : only0: Deleted 2025/04/24 04:27:24 INFO : only17: Deleted 2025/04/24 04:27:29 INFO : only14: Deleted 2025/04/24 04:27:29 INFO : only1: Deleted 2025/04/24 04:27:34 INFO : only19: Deleted 2025/04/24 04:27:34 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (343.41s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:30:04 DEBUG : both0: md5 = ddee97953fb690fcb0a6a53ccc7698e7 OK 2025/04/24 04:30:04 DEBUG : only0: md5 = 515c998af95a0f9e2663d9cd3b596db8 OK 2025/04/24 04:30:09 DEBUG : both1: md5 = ea8af7d30864531af39504c6750440a5 OK 2025/04/24 04:30:14 DEBUG : only1: md5 = 7d142bd08b65a09507dffca37334b771 OK 2025/04/24 04:30:19 DEBUG : both2: md5 = 23d33bbe1ec156fcf17d0f1001cf1224 OK 2025/04/24 04:30:20 DEBUG : only2: md5 = 39f470932a4b5760ab7df320f842bcbb OK 2025/04/24 04:30:25 DEBUG : both3: md5 = 5be2d457607e731ce6102bfd77e9d503 OK 2025/04/24 04:30:25 DEBUG : only3: md5 = 32d69606494b3d45a1e5b1fc1f9d5844 OK 2025/04/24 04:30:25 DEBUG : both4: md5 = f7e2f3e7ee7506b4143cd35f81fa6c56 OK 2025/04/24 04:30:25 DEBUG : only4: md5 = 0a906d325fc396b7f9bba7270ce05406 OK 2025/04/24 04:30:25 DEBUG : both5: md5 = dff90f4809230fd456f41f7d7052a79f OK 2025/04/24 04:30:26 DEBUG : only5: md5 = 5a04f689042c802747b5ea512f0230d5 OK 2025/04/24 04:30:31 DEBUG : both6: md5 = 036f65c6af45ea591c163ddabe99009c OK 2025/04/24 04:30:31 DEBUG : only6: md5 = d7c11a0cb35d2da4ab3747bfdace53c3 OK 2025/04/24 04:30:31 DEBUG : both7: md5 = eb2979299c1a0609be555234288e1499 OK 2025/04/24 04:30:36 DEBUG : only7: md5 = 08ca1c849af5a5da35df912f2e8b815e OK 2025/04/24 04:30:42 DEBUG : both8: md5 = 68a6cd4e781462e8be434e27bb855de9 OK 2025/04/24 04:30:47 DEBUG : only8: md5 = a43ded214ea03477c5edd9f66ac39124 OK 2025/04/24 04:30:52 DEBUG : both9: md5 = 37cdb92ab4640bb059209ef37b165457 OK 2025/04/24 04:30:57 DEBUG : only9: md5 = e3a7a1edc6a0661b667b7f8b5222c969 OK 2025/04/24 04:31:02 DEBUG : both10: md5 = cbf91326145fbbbfb265da5350c8e4bb OK 2025/04/24 04:31:02 DEBUG : only10: md5 = c8dcf96878209a941a28bc3bd37c3417 OK 2025/04/24 04:31:08 DEBUG : both11: md5 = e500ff1a776a9332735f13ef3e784be7 OK 2025/04/24 04:31:08 DEBUG : only11: md5 = 6a6a0a1fd117075fc664c152594c492d OK 2025/04/24 04:31:13 DEBUG : both12: md5 = 33c57dcf5290c463639cf4e37dc4bc2a OK 2025/04/24 04:31:18 DEBUG : only12: md5 = b6ee6d11f6cc68ad4989c291835dfbf7 OK 2025/04/24 04:31:23 DEBUG : both13: md5 = ffb6a7637b7149f076c731ccb43ea970 OK 2025/04/24 04:31:29 DEBUG : only13: md5 = 516cd57ac4a730fc6b50a257d5711fe7 OK 2025/04/24 04:31:34 DEBUG : both14: md5 = fdf8ba20ca3dda540144208b83ae61a4 OK 2025/04/24 04:31:39 DEBUG : only14: md5 = 38538b354b7c411afd1a28e3da8e8378 OK 2025/04/24 04:31:44 DEBUG : both15: md5 = f4d3bff34e6e44a0121095b3fa457b44 OK 2025/04/24 04:31:44 DEBUG : only15: md5 = 84891a8bb6f55a2ed89db3249f1aad3f OK 2025/04/24 04:31:49 DEBUG : both16: md5 = ea46a2dcc6ded03dd27c3213f9f64604 OK 2025/04/24 04:31:49 DEBUG : only16: md5 = 9a4c0ca82e5668da7d300d63c81eabf4 OK 2025/04/24 04:31:54 DEBUG : both17: md5 = 91108c958adaf9e387eab5701b305019 OK 2025/04/24 04:31:55 DEBUG : only17: md5 = 5d227a29422f826789e554ce4cb4b3a7 OK 2025/04/24 04:32:00 DEBUG : both18: md5 = c65391e6085033ff25db87d45ea78c17 OK 2025/04/24 04:32:00 DEBUG : only18: md5 = 0d1c73a9ec4f8f9e73b7980478b68309 OK 2025/04/24 04:32:05 DEBUG : both19: md5 = 6e08534de3a4359732f5b83f66283f9f OK 2025/04/24 04:32:10 DEBUG : only19: md5 = de6de8746843ebae48c33f93b3e0f9d4 OK 2025/04/24 04:32:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for checks to finish 2025/04/24 04:32:57 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:57 DEBUG : both0: Unchanged skipping 2025/04/24 04:32:57 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:57 DEBUG : both1: Unchanged skipping 2025/04/24 04:32:57 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:57 DEBUG : both10: Unchanged skipping 2025/04/24 04:32:57 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:57 DEBUG : both11: Unchanged skipping 2025/04/24 04:32:57 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:57 DEBUG : both13: Unchanged skipping 2025/04/24 04:32:57 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:57 DEBUG : both14: Unchanged skipping 2025/04/24 04:32:57 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:57 DEBUG : both15: Unchanged skipping 2025/04/24 04:32:57 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:57 DEBUG : both16: Unchanged skipping 2025/04/24 04:32:58 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:58 DEBUG : both18: Unchanged skipping 2025/04/24 04:32:58 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:32:58 DEBUG : both2: Unchanged skipping 2025/04/24 04:33:02 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:02 DEBUG : both12: Unchanged skipping 2025/04/24 04:33:02 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:02 DEBUG : both4: Unchanged skipping 2025/04/24 04:33:02 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:02 DEBUG : both17: Unchanged skipping 2025/04/24 04:33:03 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:03 DEBUG : both5: Unchanged skipping 2025/04/24 04:33:03 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:03 DEBUG : both19: Unchanged skipping 2025/04/24 04:33:03 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:03 DEBUG : both7: Unchanged skipping 2025/04/24 04:33:03 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:03 DEBUG : both8: Unchanged skipping 2025/04/24 04:33:03 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/04/24 04:33:03 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:03 DEBUG : both3: Unchanged skipping 2025/04/24 04:33:03 DEBUG : only0: md5 = 45ed4be7f19b6377fbe08a3efbd840b3 OK 2025/04/24 04:33:03 INFO : only0: Copied (replaced existing) 2025/04/24 04:33:03 DEBUG : only10: md5 = 5e6d871993eccb28ce73cc1978761f12 OK 2025/04/24 04:33:03 INFO : only10: Copied (replaced existing) 2025/04/24 04:33:03 DEBUG : only11: md5 = 674f2bb9e49c592a562b36c2198088f3 OK 2025/04/24 04:33:03 INFO : only11: Copied (replaced existing) 2025/04/24 04:33:08 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:08 DEBUG : both6: Unchanged skipping 2025/04/24 04:33:08 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/24 04:33:08 DEBUG : both9: Unchanged skipping 2025/04/24 04:33:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Waiting for transfers to finish 2025/04/24 04:33:08 DEBUG : only1: md5 = ad56bd20bb914db52d594369ef40c2b0 OK 2025/04/24 04:33:08 INFO : only1: Copied (replaced existing) 2025/04/24 04:33:08 DEBUG : only15: md5 = 062334710921c977bb727f9784f47806 OK 2025/04/24 04:33:08 INFO : only15: Copied (replaced existing) 2025/04/24 04:33:08 DEBUG : only14: md5 = 6cb15d242d2c3c92f1c97bdd297e5a78 OK 2025/04/24 04:33:08 INFO : only14: Copied (replaced existing) 2025/04/24 04:33:08 DEBUG : only16: md5 = 02d7af0135bd4b49b36b5dd400e72231 OK 2025/04/24 04:33:08 INFO : only16: Copied (replaced existing) 2025/04/24 04:33:08 DEBUG : only17: md5 = a4f6c69cde87aba0c8881ed964199f27 OK 2025/04/24 04:33:08 INFO : only17: Copied (replaced existing) 2025/04/24 04:33:08 DEBUG : only18: md5 = 6593d265f1f99062a41684163d0f5684 OK 2025/04/24 04:33:08 INFO : only18: Copied (replaced existing) 2025/04/24 04:33:08 DEBUG : only13: md5 = 987f98d7c7e8814c293c226462e13717 OK 2025/04/24 04:33:08 INFO : only13: Copied (replaced existing) 2025/04/24 04:33:09 DEBUG : only3: md5 = 88d57df3af453c18ba02787af610e8d5 OK 2025/04/24 04:33:09 INFO : only3: Copied (replaced existing) 2025/04/24 04:33:09 DEBUG : only2: md5 = 06d23c6affb9cd16a27dd1bf390c6a56 OK 2025/04/24 04:33:09 INFO : only2: Copied (replaced existing) 2025/04/24 04:33:09 DEBUG : only4: md5 = 90c1953aec94f3dca4de91ae5c87c262 OK 2025/04/24 04:33:09 INFO : only4: Copied (replaced existing) 2025/04/24 04:33:09 DEBUG : only5: md5 = 6f91c046a784891d255d765d67bdb17f OK 2025/04/24 04:33:09 INFO : only5: Copied (replaced existing) 2025/04/24 04:33:09 DEBUG : only6: md5 = bc9d810adbadc71297a19ae53cad73b8 OK 2025/04/24 04:33:09 INFO : only6: Copied (replaced existing) 2025/04/24 04:33:13 DEBUG : only12: md5 = 200b954cfe2647f84a7893dd63de0d1d OK 2025/04/24 04:33:13 INFO : only12: Copied (replaced existing) 2025/04/24 04:33:14 DEBUG : only8: md5 = 5ad7b8a74a55a78635fd155537dee123 OK 2025/04/24 04:33:14 INFO : only8: Copied (replaced existing) 2025/04/24 04:33:19 DEBUG : only19: md5 = 5c6df0848e4244a087341acc07598ce5 OK 2025/04/24 04:33:19 INFO : only19: Copied (replaced existing) 2025/04/24 04:33:19 DEBUG : only7: md5 = 29e2e1b44c445893a826e20b14fad0db OK 2025/04/24 04:33:19 INFO : only7: Copied (replaced existing) 2025/04/24 04:33:23 DEBUG : only9: md5 = a66bac2b10845c45e22f966a2ce4a862 OK 2025/04/24 04:33:23 INFO : only9: Copied (replaced existing) 2025/04/24 04:33:23 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (433.68s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:37:17 DEBUG : empty_dir: Making directory with metadata 2025/04/24 04:37:17 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/24 04:37:17 DEBUG : empty_on_remote: Making directory with metadata 2025/04/24 04:37:17 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/24 04:37:17 INFO : empty_on_remote: Making directory 2025/04/24 04:37:17 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-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:37:18 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/04/24 04:37:18 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/04/24 04:37:18 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/04/24 04:37:18 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTime (2.38s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:37:20 DEBUG : empty_dir: Making directory with metadata 2025/04/24 04:37:20 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/24 04:37:20 DEBUG : empty_on_remote: Making directory with metadata 2025/04/24 04:37:20 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/04/24 04:37:20 INFO : empty_on_remote: Making directory 2025/04/24 04:37:20 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-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:37:20 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/04/24 04:37:20 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/04/24 04:37:20 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/04/24 04:37:20 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/04/24 04:37:20 INFO : empty_dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (1.87s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:37:21 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/24 04:37:21 INFO : sub dir: Making directory 2025/04/24 04:37:21 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-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (22.43s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" 2025/04/24 04:37:44 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/04/24 04:37:44 INFO : sub dir: Making directory 2025/04/24 04:37:44 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-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu'", Local "Local file system at /tmp/rclone3387311013", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (21.60s) PASS 2025/04/24 04:38:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiwoviq3gofu': Purge remote 2025/04/24 04:38:05 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 55m57.178907156s (try 1/5)