"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 4/5) 2025/06/19 06:37:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi" 2025/06/19 06:37:15 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:37:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi.bin" 2025/06/19 06:37:15 DEBUG : Swift container crypt path rclone-test-majesad5gepi.bin: Auto set use_segments_container to true 2025/06/19 06:37:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi" 2025/06/19 06:37:21 DEBUG : Swift container crypt path rclone-test-majesad5gepi: Auto set use_segments_container to true 2025/06/19 06:37:26 DEBUG : Creating backend with remote "/tmp/rclone3234654002" === 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-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:37:26 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:37:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:37:26 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/06/19 06:37:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish --- PASS: TestCopyWithDryRun (0.54s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:37:27 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/19 06:37:27 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:37:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:37:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:37:32 DEBUG : sub dir/hello world: md5 = 74d484e77cd83a374c65a87a5065a777 OK 2025/06/19 06:37:32 INFO : sub dir/hello world: Copied (new) 2025/06/19 06:37:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (15.83s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:98: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.19s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:98: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.16s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:37:43 DEBUG : Creating backend with remote "/non-existing" 2025/06/19 06:37:43 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/06/19 06:37:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:37:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.30s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:37:48 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:37:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:37:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:37:53 DEBUG : sub dir/hello world: md5 = c18c2da35cc0d4161cd4cefdbcd67f9b OK 2025/06/19 06:37:53 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (20.90s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:38:04 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Running all checks before starting transfers 2025/06/19 06:38:04 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:38:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:38:04 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Checks finished, now starting transfers 2025/06/19 06:38:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:38:09 DEBUG : sub dir/hello world: md5 = 965ba9e0052c7379f49b9a8719e1f0ed OK 2025/06/19 06:38:09 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (10.86s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:38:15 ERROR : Ignoring --no-traverse with sync 2025/06/19 06:38:15 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:38:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:38:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:38:20 DEBUG : sub dir/hello world: md5 = 08d17b6fb8eb4e0ef8a4800a917f404a OK 2025/06/19 06:38:20 INFO : sub dir/hello world: Copied (new) 2025/06/19 06:38:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (10.79s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:38:26 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/06/19 06:38:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:38:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:38:31 DEBUG : hello world2: md5 = 6ff31468723f247f5cb97d0b7dba2f4a OK 2025/06/19 06:38:31 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (11.10s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:38:37 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:38:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:38:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:38:42 DEBUG : potato2: md5 = af241cfc07e6ea7fb4c99cd79eb1b26c OK 2025/06/19 06:38:42 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (16.16s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:38:58 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:38:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:38:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:39:03 DEBUG : potato2: md5 = eeb879382b9144218d2c6c0a86c3270e OK 2025/06/19 06:39:03 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (16.29s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:39:09 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/06/19 06:39:09 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/19 06:39:09 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/06/19 06:39:09 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/19 06:39:09 INFO : sub dir2: Making directory 2025/06/19 06:39:09 INFO : sub dir: Making directory 2025/06/19 06:39:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:39:09 INFO : sub dir2/sub sub dir2: Making directory 2025/06/19 06:39:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:39:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:39:15 DEBUG : sub dir/hello world: md5 = 81932e88df80456fac0f1875b19457b3 OK 2025/06/19 06:39:15 INFO : sub dir/hello world: Copied (new) fstest.go:247: Filtering empty directory "sub dir2" fstest.go:247: Filtering empty directory "sub dir2/sub sub dir2" 2025/06/19 06:39:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (16.15s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:39:25 INFO : sub dir2: Making directory 2025/06/19 06:39:25 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/06/19 06:39:25 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/19 06:39:26 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:39:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:39:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:39:31 DEBUG : sub dir/hello world: md5 = 228c11c6fdb3a4cdb1d20b94b60249a3 OK 2025/06/19 06:39:31 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (21.51s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:39:47 DEBUG : sub dir2: Making directory with metadata 2025/06/19 06:39:47 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/19 06:39:47 INFO : sub dir2: Making directory 2025/06/19 06:39:47 INFO : sub dir: Making directory 2025/06/19 06:39:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:39:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:39:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:39:52 DEBUG : sub dir/hello world: md5 = 41aa6a7d760e20b4f4d055930e108958 OK 2025/06/19 06:39:52 INFO : sub dir/hello world: Copied (new) 2025/06/19 06:39:52 INFO : sub dir/hello world: Deleted fstest.go:247: Filtering empty directory "sub dir2" 2025/06/19 06:39:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/06/19 06:39:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (21.23s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:409: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.20s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:40:08 INFO : sub dir2: Making directory 2025/06/19 06:40:08 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:40:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:40:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:40:14 DEBUG : sub dir/hello world: md5 = d3ffe3a5105d943b57469207e28db462 OK 2025/06/19 06:40:14 INFO : sub dir/hello world: Copied (new) 2025/06/19 06:40:14 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (10.73s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:40:19 DEBUG : sub dir2: Making directory with metadata 2025/06/19 06:40:19 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/19 06:40:19 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/19 06:40:19 INFO : sub dir2: Making directory 2025/06/19 06:40:19 INFO : sub dir: Making directory 2025/06/19 06:40:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:40:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:40:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:40:24 DEBUG : sub dir/hello world: md5 = 93723765993850077a6d47186edb24b2 OK 2025/06/19 06:40:24 INFO : sub dir/hello world: Copied (new) 2025/06/19 06:40:24 DEBUG : Waiting for deletions to finish fstest.go:247: Filtering empty directory "sub dir2" 2025/06/19 06:40:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (10.70s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:508: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.31s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:40:30 INFO : sub dir2: Making directory 2025/06/19 06:40:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:40:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:40:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:40:35 DEBUG : sub dir/hello world: md5 = e02d51c02253a5dc00e4596ede8559c3 OK 2025/06/19 06:40:35 INFO : sub dir/hello world: Copied (new) 2025/06/19 06:40:35 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (10.86s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:40:46 DEBUG : sub dir/hello world: md5 = 6484fbf5ffb54b747396eacedbd6fd1c OK 2025/06/19 06:40:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bemivuk4suqa" 2025/06/19 06:40:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bemivuk4suqa.bin" 2025/06/19 06:40:52 DEBUG : Swift container crypt path rclone-test-bemivuk4suqa.bin: Auto set use_segments_container to true 2025/06/19 06:40:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bemivuk4suqa" 2025/06/19 06:40:58 DEBUG : Swift container crypt path rclone-test-bemivuk4suqa: Auto set use_segments_container to true sync_test.go:591: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi' -> Encrypted drive 'TestCryptSwift:rclone-test-bemivuk4suqa' 2025/06/19 06:41:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:41:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bemivuk4suqa': Waiting for checks to finish 2025/06/19 06:41:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bemivuk4suqa': Waiting for transfers to finish 2025/06/19 06:41:19 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/19 06:41:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bemivuk4suqa': Purge remote 2025/06/19 06:41:19 DEBUG : Waiting for deletions to finish 2025/06/19 06:41:29 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (53.74s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:41:40 DEBUG : sub dir/hello world: md5 = c2ce87069b1a306a820c8e43c4b4d729 OK 2025/06/19 06:41:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:41:40 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/19 06:41:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:41:46 DEBUG : sub dir/hello world: md5 = f84e8563ffac9d37d2d29aa6c985a245 OK 2025/06/19 06:41:46 INFO : sub dir/hello world: Copied (replaced existing) --- PASS: TestCopyOverSelf (21.42s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:42:01 DEBUG : sub dir/hello world: md5 = 2bb7b9ebdc8f456932bd0f1ad3df23f8 OK 2025/06/19 06:42:01 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuveqid0jobo" 2025/06/19 06:42:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuveqid0jobo.bin" 2025/06/19 06:42:02 DEBUG : Swift container crypt path rclone-test-wuveqid0jobo.bin: Auto set use_segments_container to true 2025/06/19 06:42:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuveqid0jobo" 2025/06/19 06:42:08 DEBUG : Swift container crypt path rclone-test-wuveqid0jobo: Auto set use_segments_container to true sync_test.go:627: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi' -> Encrypted drive 'TestCryptSwift:rclone-test-wuveqid0jobo' 2025/06/19 06:42:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:42:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuveqid0jobo': Waiting for checks to finish 2025/06/19 06:42:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuveqid0jobo': Waiting for transfers to finish 2025/06/19 06:42:34 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/19 06:42:39 DEBUG : sub dir/hello world: md5 = 8ebb1e5944aacb9bb213a1edc22f8f41 OK 2025/06/19 06:42:39 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/19 06:42:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuveqid0jobo': Waiting for checks to finish 2025/06/19 06:42:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuveqid0jobo': Waiting for transfers to finish 2025/06/19 06:42:55 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/19 06:43:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuveqid0jobo': Purge remote 2025/06/19 06:43:00 DEBUG : Waiting for deletions to finish 2025/06/19 06:43:10 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (79.41s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:43:21 DEBUG : sub dir/hello world: md5 = be4987d73c0ed66b8945e24c7c790705 OK 2025/06/19 06:43:21 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/19 06:43:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:43:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:43:26 DEBUG : sub dir/hello world: md5 = 7895337428587d4466ddc1703897f669 OK 2025/06/19 06:43:26 INFO : sub dir/hello world: Copied (replaced existing) 2025/06/19 06:43:26 INFO : sub dir/hello world: Deleted --- PASS: TestMoveOverSelf (16.39s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:43:37 DEBUG : sub dir/hello world: md5 = 5b783d90761695a80eac6a70f802e2ee OK 2025/06/19 06:43:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-favomor7fira" 2025/06/19 06:43:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-favomor7fira.bin" 2025/06/19 06:43:38 DEBUG : Swift container crypt path rclone-test-favomor7fira.bin: Auto set use_segments_container to true 2025/06/19 06:43:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-favomor7fira" 2025/06/19 06:43:43 DEBUG : Swift container crypt path rclone-test-favomor7fira: Auto set use_segments_container to true sync_test.go:672: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi' -> Encrypted drive 'TestCryptSwift:rclone-test-favomor7fira' 2025/06/19 06:43:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:43:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-favomor7fira': Waiting for checks to finish 2025/06/19 06:43:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-favomor7fira': Waiting for transfers to finish 2025/06/19 06:43:59 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/19 06:44:05 DEBUG : sub dir/hello world: md5 = 556703cdee0b37163d61859c287f33ab OK 2025/06/19 06:44:10 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/19 06:44:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-favomor7fira': Waiting for checks to finish 2025/06/19 06:44:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-favomor7fira': Waiting for transfers to finish 2025/06/19 06:44:15 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/19 06:44:20 INFO : sub dir/hello world: Deleted 2025/06/19 06:44:26 DEBUG : sub dir/hello world: md5 = 56d22564d10bada8843d2e4fe5f42046 OK 2025/06/19 06:44:26 DEBUG : testing file moves 2025/06/19 06:44:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-favomor7fira': Waiting for checks to finish 2025/06/19 06:44:26 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/06/19 06:44:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-favomor7fira': Waiting for transfers to finish 2025/06/19 06:44:31 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/19 06:44:37 INFO : sub dir/hello world: Deleted 2025/06/19 06:44:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-favomor7fira': Purge remote 2025/06/19 06:44:37 DEBUG : Waiting for deletions to finish 2025/06/19 06:44:37 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (65.38s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:44:42 DEBUG : sub dir/hello world: md5 = f10c0f75cc92e56ec259fe803b0ee6aa OK 2025/06/19 06:44:42 ERROR : error listing: directory not found 2025/06/19 06:44:43 INFO : Local file system at /tmp/rclone3234654002: Making directory 2025/06/19 06:44:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:44:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish --- PASS: TestCopyAfterDelete (16.17s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:44:59 DEBUG : sub dir/hello world: md5 = 746f4ea6dc679ff4890458655df7fa27 OK 2025/06/19 06:45:04 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:45:04 DEBUG : Local file system at /tmp/rclone3234654002: Waiting for checks to finish 2025/06/19 06:45:04 DEBUG : Local file system at /tmp/rclone3234654002: Waiting for transfers to finish 2025/06/19 06:45:04 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/06/19 06:45:04 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (21.28s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:45:15 DEBUG : check sum: Need to transfer - File not found at Destination 2025/06/19 06:45:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:45:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:45:20 DEBUG : check sum: md5 = ebf1c2a1131d592137b267e734e7b165 OK 2025/06/19 06:45:20 INFO : check sum: Copied (new) 2025/06/19 06:45:20 DEBUG : Waiting for deletions to finish 2025/06/19 06:45:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:45:25 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/06/19 06:45:25 DEBUG : check sum: Size of src and dst objects identical 2025/06/19 06:45:25 DEBUG : check sum: Unchanged skipping 2025/06/19 06:45:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:45:25 DEBUG : Waiting for deletions to finish 2025/06/19 06:45:25 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (21.14s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:45:36 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/06/19 06:45:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:45:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:45:42 DEBUG : sizeonly: md5 = 6b640ca9ecc5f3554fc9fe1af7059187 OK 2025/06/19 06:45:42 INFO : sizeonly: Copied (new) 2025/06/19 06:45:42 DEBUG : Waiting for deletions to finish 2025/06/19 06:45:43 DEBUG : sizeonly: Sizes identical 2025/06/19 06:45:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:45:43 DEBUG : sizeonly: Unchanged skipping 2025/06/19 06:45:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:45:43 DEBUG : Waiting for deletions to finish 2025/06/19 06:45:43 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (22.16s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:45:58 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/06/19 06:45:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:45:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:45:58 DEBUG : ignore-size: md5 = 277be110a2fb2efe764c5edb7b41414d OK 2025/06/19 06:45:58 INFO : ignore-size: Copied (new) 2025/06/19 06:45:58 DEBUG : Waiting for deletions to finish 2025/06/19 06:45:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:45:59 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:45:59 DEBUG : ignore-size: Unchanged skipping 2025/06/19 06:45:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:45:59 DEBUG : Waiting for deletions to finish 2025/06/19 06:45:59 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (1.23s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:46:05 DEBUG : existing: md5 = a8d21a11e13014b81aa2fa88297aa07f OK 2025/06/19 06:46:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:46:05 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:46:05 DEBUG : existing: Unchanged skipping 2025/06/19 06:46:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:46:05 DEBUG : Waiting for deletions to finish 2025/06/19 06:46:05 INFO : There was nothing to transfer 2025/06/19 06:46:05 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/06/19 06:46:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:46:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:46:10 DEBUG : existing: md5 = 98e1ca15ca50c71c8f7de847cbba3e48 OK 2025/06/19 06:46:10 INFO : existing: Copied (replaced existing) 2025/06/19 06:46:10 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (16.64s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:46:16 DEBUG : existing: Need to transfer - File not found at Destination 2025/06/19 06:46:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:46:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:46:21 DEBUG : existing: md5 = 4ce811e5e63be947a67e4c2d88abfef4 OK 2025/06/19 06:46:21 INFO : existing: Copied (new) 2025/06/19 06:46:21 DEBUG : Waiting for deletions to finish 2025/06/19 06:46:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:46:26 DEBUG : existing: Destination exists, skipping 2025/06/19 06:46:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:46:26 DEBUG : Waiting for deletions to finish 2025/06/19 06:46:26 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (20.85s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:46:37 DEBUG : b/potato: md5 = 74ed4d1d7496cb96759dd06d38f3a0c8 OK 2025/06/19 06:46:37 DEBUG : c/non empty space: md5 = e8f779e3fc2b08d122e28c4a91f8b2c5 OK 2025/06/19 06:46:37 INFO : d: Making directory fstest.go:247: Filtering empty directory "d" 2025/06/19 06:46:38 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/06/19 06:46:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:46:38 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:46:38 DEBUG : c/non empty space: Unchanged skipping 2025/06/19 06:46:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:46:43 DEBUG : a/potato2: md5 = fe530f7e1397292d441cbf77cc2c4457 OK 2025/06/19 06:46:43 INFO : a/potato2: Copied (new) 2025/06/19 06:46:43 DEBUG : Waiting for deletions to finish 2025/06/19 06:46:43 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (17.54s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:47:00 DEBUG : empty space: md5 = eda657c0596c2a1cff688dcdfcbec383 OK 2025/06/19 06:47:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:47:05 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/06/19 06:47:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:47:05 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/06/19 06:47:05 DEBUG : Waiting for deletions to finish 2025/06/19 06:47:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:47:10 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/06/19 06:47:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:47:15 DEBUG : empty space: md5 = 9b9f709e71702bf0a85424a9b068d33e OK 2025/06/19 06:47:15 INFO : empty space: Copied (replaced existing) 2025/06/19 06:47:15 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingModtimeOnly (31.79s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:1017: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.10s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:47:31 DEBUG : foo: md5 = 82d95b1f2699a030388178e79b5ad24e OK 2025/06/19 06:47:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:47:37 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/06/19 06:47:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:47:42 DEBUG : foo: md5 = be132f17f8f806f634a11575d9a4c9c3 OK 2025/06/19 06:47:42 INFO : foo: Copied (replaced existing) 2025/06/19 06:47:42 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (26.37s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:47:58 DEBUG : empty space: md5 = 70f5be4b29f5a831334db66408a63c6d OK 2025/06/19 06:47:58 DEBUG : potato: Need to transfer - File not found at Destination 2025/06/19 06:47:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:47:58 DEBUG : potato: md5 = b13e97234dc49d922ac599f4de995bcc OK 2025/06/19 06:47:58 INFO : potato: Copied (new) 2025/06/19 06:48:03 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:48:03 DEBUG : empty space: Unchanged skipping 2025/06/19 06:48:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:48:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (21.26s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:48:14 DEBUG : potato: md5 = bd71f15a648eb1ac03213ebf9f0137a1 OK 2025/06/19 06:48:14 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/06/19 06:48:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:48:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:48:14 DEBUG : potato: md5 = af144cc6966cae188c66a9fb2669d5c8 OK 2025/06/19 06:48:14 INFO : potato: Copied (replaced existing) 2025/06/19 06:48:14 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (1.19s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:48:15 DEBUG : potato: md5 = a22d852e8a4a43fc220fcdab1eb88d64 OK 2025/06/19 06:48:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:48:16 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/06/19 06:48:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:48:16 DEBUG : potato: md5 = a7120dd50af361a99b1b8266d0cea018 OK 2025/06/19 06:48:16 INFO : potato: Copied (replaced existing) 2025/06/19 06:48:16 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (1.64s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:48:17 DEBUG : potato: md5 = f5ee05f6fc9a9af46a4ece66d2a5d81c OK 2025/06/19 06:48:23 DEBUG : empty space: md5 = f21ff540cd71cf8397b8c59e48bf37e2 OK 2025/06/19 06:48:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:48:23 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/06/19 06:48:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:48:28 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:48:28 DEBUG : empty space: Unchanged skipping 2025/06/19 06:48:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:48:28 DEBUG : Waiting for deletions to finish 2025/06/19 06:48:28 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (27.52s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:48:44 DEBUG : potato: md5 = bc0f2746f1b2049f0db546b9f97a0ea4 OK 2025/06/19 06:48:50 DEBUG : empty space: md5 = 28c0a369e192a0069406d0861aec9690 OK 2025/06/19 06:48:55 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:48:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:49:00 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:49:00 DEBUG : empty space: Unchanged skipping 2025/06/19 06:49:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:49:00 DEBUG : potato2: md5 = e3a6035edc5a1244d88547333770f2de OK 2025/06/19 06:49:00 INFO : potato2: Copied (new) 2025/06/19 06:49:00 DEBUG : Waiting for deletions to finish 2025/06/19 06:49:00 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (31.76s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:49:16 DEBUG : b/potato: md5 = 23d7bec85571b474bdd3a131432f6414 OK 2025/06/19 06:49:16 DEBUG : c/non empty space: md5 = 751c6e31fb67951acc3b3d8c58b3bc15 OK 2025/06/19 06:49:16 INFO : d: Making directory 2025/06/19 06:49:16 INFO : d/e: Making directory fstest.go:247: Filtering empty directory "d" fstest.go:247: Filtering empty directory "d/e" 2025/06/19 06:49:17 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/06/19 06:49:17 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:49:17 DEBUG : c/non empty space: Unchanged skipping 2025/06/19 06:49:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:49:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:49:22 DEBUG : a/potato2: md5 = ab1e10e8d6f771b28f9168675c843f7b OK 2025/06/19 06:49:22 INFO : a/potato2: Copied (new) 2025/06/19 06:49:22 DEBUG : Waiting for deletions to finish 2025/06/19 06:49:22 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (23.33s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:49:40 DEBUG : b/potato: md5 = 3f97c8ebb46ce69097a17e957f3e1a79 OK 2025/06/19 06:49:40 DEBUG : c/non empty space: md5 = 2e726e88339950d3532d4b5969b13083 OK 2025/06/19 06:49:40 INFO : d: Making directory fstest.go:247: Filtering empty directory "d" 2025/06/19 06:49:40 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/06/19 06:49:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:49:40 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:49:40 DEBUG : c/non empty space: Unchanged skipping 2025/06/19 06:49:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:49:45 DEBUG : a/potato2: md5 = 85769e8b6808641328a8b33c281b5d72 OK 2025/06/19 06:49:45 INFO : a/potato2: Copied (new) 2025/06/19 06:49:45 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': not deleting files as there were IO errors 2025/06/19 06:49:45 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': not deleting directories as there were IO errors fstest.go:247: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (17.03s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:49:56 DEBUG : potato: md5 = 0c9424e9db4f59ec31080ae0218c487e OK 2025/06/19 06:50:02 DEBUG : empty space: md5 = a002b2e640247e61d1310232ca2fc728 OK 2025/06/19 06:50:02 DEBUG : Waiting for deletions to finish 2025/06/19 06:50:02 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:50:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:50:02 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:50:02 DEBUG : empty space: Unchanged skipping 2025/06/19 06:50:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:50:02 INFO : potato: Deleted 2025/06/19 06:50:07 DEBUG : potato2: md5 = fda022103ab5fea9bc7c2312130ee27b OK 2025/06/19 06:50:07 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteDuring (31.91s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:50:28 DEBUG : potato: md5 = 34d012b770d14a566318291e5c0f37fe OK 2025/06/19 06:50:34 DEBUG : empty space: md5 = b4a294dfd43c130b8361195ba499c983 OK 2025/06/19 06:50:34 DEBUG : Waiting for deletions to finish 2025/06/19 06:50:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:50:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:50:34 INFO : potato: Deleted 2025/06/19 06:50:34 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:50:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:50:39 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:50:39 DEBUG : empty space: Unchanged skipping 2025/06/19 06:50:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:50:39 DEBUG : potato2: md5 = 70dc240a2aed16a4d5d1c78d42c906cc OK 2025/06/19 06:50:39 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (39.86s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:51:08 DEBUG : potato: md5 = ef61e6036b610b12fde4d4462695d99a OK 2025/06/19 06:51:09 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:51:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:51:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:51:14 DEBUG : potato2: md5 = 8557a31266e787e436466e235a9e6481 OK 2025/06/19 06:51:14 INFO : potato2: Copied (new) --- PASS: TestCopyDeleteBefore (11.37s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:51:25 DEBUG : potato2: md5 = 71e21fe9fb642f396f0a98e307f1a2bd OK 2025/06/19 06:51:30 DEBUG : empty space: md5 = e11fe7f3d13be56af8176d0fb5e9a692 OK 2025/06/19 06:51:35 DEBUG : enormous: Excluded (Size Filter) 2025/06/19 06:51:35 DEBUG : enormous: Excluded 2025/06/19 06:51:35 DEBUG : potato2: Excluded (Size Filter) 2025/06/19 06:51:35 DEBUG : potato2: Excluded 2025/06/19 06:51:35 DEBUG : potato2: Excluded (Size Filter) 2025/06/19 06:51:35 DEBUG : potato2: Excluded 2025/06/19 06:51:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:51:40 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:51:40 DEBUG : empty space: Unchanged skipping 2025/06/19 06:51:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:51:40 DEBUG : Waiting for deletions to finish 2025/06/19 06:51:40 INFO : There was nothing to transfer 2025/06/19 06:51:40 DEBUG : enormous: Excluded (Size Filter) 2025/06/19 06:51:40 DEBUG : enormous: Excluded 2025/06/19 06:51:40 DEBUG : potato2: Excluded (Size Filter) 2025/06/19 06:51:40 DEBUG : potato2: Excluded 2025/06/19 06:51:40 DEBUG : potato2: Excluded (Size Filter) 2025/06/19 06:51:40 DEBUG : potato2: Excluded 2025/06/19 06:51:40 DEBUG : Local file system at /tmp/rclone3234654002: Waiting for checks to finish 2025/06/19 06:51:40 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:51:40 DEBUG : empty space: Unchanged skipping 2025/06/19 06:51:40 DEBUG : Local file system at /tmp/rclone3234654002: Waiting for transfers to finish 2025/06/19 06:51:40 DEBUG : Waiting for deletions to finish 2025/06/19 06:51:40 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (36.33s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:52:01 DEBUG : potato2: md5 = fa94931cbcdf6e1500d7db834494385b OK 2025/06/19 06:52:06 DEBUG : empty space: md5 = 8e05a0b2383408c8e375b05443b08470 OK 2025/06/19 06:52:07 DEBUG : enormous: md5 = 6271c3e5ecf58242f52548fc6cfd4185 OK 2025/06/19 06:52:12 DEBUG : enormous: Excluded (Size Filter) 2025/06/19 06:52:12 DEBUG : enormous: Excluded 2025/06/19 06:52:12 DEBUG : potato2: Excluded (Size Filter) 2025/06/19 06:52:12 DEBUG : potato2: Excluded 2025/06/19 06:52:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:52:17 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:52:17 DEBUG : empty space: Unchanged skipping 2025/06/19 06:52:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:52:17 DEBUG : Waiting for deletions to finish 2025/06/19 06:52:17 INFO : enormous: Deleted 2025/06/19 06:52:27 INFO : potato2: Deleted 2025/06/19 06:52:27 INFO : There was nothing to transfer 2025/06/19 06:52:28 DEBUG : Local file system at /tmp/rclone3234654002: Waiting for checks to finish 2025/06/19 06:52:28 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:52:28 DEBUG : empty space: Unchanged skipping 2025/06/19 06:52:28 DEBUG : Local file system at /tmp/rclone3234654002: Waiting for transfers to finish 2025/06/19 06:52:28 DEBUG : Waiting for deletions to finish 2025/06/19 06:52:28 INFO : enormous: Deleted 2025/06/19 06:52:28 INFO : potato2: Deleted 2025/06/19 06:52:28 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (37.08s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:52:38 DEBUG : one: md5 = 9ab641cd12e4bd07bc5f7d5f355ed9fd OK 2025/06/19 06:52:44 DEBUG : two: md5 = 6249b6bad9f100e24cb37d6e227c3022 OK 2025/06/19 06:52:44 DEBUG : three: md5 = 3b0e577e5a2fe92adf698669946acda8 OK 2025/06/19 06:52:49 DEBUG : four: md5 = 8ec299739b05a983926515b001ff4608 OK 2025/06/19 06:52:55 DEBUG : five: Need to transfer - File not found at Destination 2025/06/19 06:52:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:52:55 DEBUG : one: Destination is newer than source, skipping 2025/06/19 06:52:55 DEBUG : three: Sizes identical 2025/06/19 06:52:55 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/06/19 06:53:00 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/06/19 06:53:00 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/06/19 06:53:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:53:00 DEBUG : five: md5 = d51f01c6a0e43ee6c670f6dd4ee35cf2 OK 2025/06/19 06:53:00 INFO : five: Copied (new) 2025/06/19 06:53:00 DEBUG : two: md5 = 9a51e1cfac916483aeba24f6a316c98a OK 2025/06/19 06:53:00 INFO : two: Copied (replaced existing) 2025/06/19 06:53:05 DEBUG : four: md5 = d55a73c740f1564ba829a22ab5ee6d6f OK 2025/06/19 06:53:05 INFO : four: Copied (replaced existing) 2025/06/19 06:53:05 DEBUG : Waiting for deletions to finish sync_test.go:1450: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (63.63s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1467: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1467: 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-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:1539: Can track renames: false 2025/06/19 06:53:36 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Ignoring --track-renames as the source and destination do not have a common hash 2025/06/19 06:53:37 DEBUG : potato: Need to transfer - File not found at Destination 2025/06/19 06:53:37 DEBUG : yam: Need to transfer - File not found at Destination 2025/06/19 06:53:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:53:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:53:37 DEBUG : potato: md5 = ecd8341ac1140e17aeb96235eb01f49a OK 2025/06/19 06:53:37 INFO : potato: Copied (new) 2025/06/19 06:53:37 DEBUG : yam: md5 = d49839597e528c7cf01612f8879ce932 OK 2025/06/19 06:53:37 INFO : yam: Copied (new) 2025/06/19 06:53:37 DEBUG : Waiting for deletions to finish 2025/06/19 06:53:37 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Ignoring --track-renames as the source and destination do not have a common hash 2025/06/19 06:53:37 DEBUG : yaml: Need to transfer - File not found at Destination 2025/06/19 06:53:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:53:37 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:53:37 DEBUG : potato: Unchanged skipping 2025/06/19 06:53:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:53:38 DEBUG : yaml: md5 = 48bad53417c88bd4a3ecda22cfa74c31 OK 2025/06/19 06:53:38 INFO : yaml: Copied (new) 2025/06/19 06:53:38 DEBUG : Waiting for deletions to finish 2025/06/19 06:53:38 INFO : yam: Deleted --- PASS: TestSyncWithTrackRenames (2.13s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:1611: Can track renames: true 2025/06/19 06:53:39 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Making map for --track-renames 2025/06/19 06:53:39 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Finished making map for --track-renames 2025/06/19 06:53:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:53:39 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/19 06:53:39 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/19 06:53:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for renames to finish 2025/06/19 06:53:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:53:39 DEBUG : potato: md5 = 6ba68b41ddc196a2c8c1fce513369e82 OK 2025/06/19 06:53:39 INFO : potato: Copied (new) 2025/06/19 06:53:39 DEBUG : yam: md5 = bae4dcb22352e0c783a8d61f1eec19be OK 2025/06/19 06:53:39 INFO : yam: Copied (new) 2025/06/19 06:53:39 DEBUG : Waiting for deletions to finish 2025/06/19 06:53:39 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Making map for --track-renames 2025/06/19 06:53:39 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Finished making map for --track-renames 2025/06/19 06:53:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:53:39 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:53:39 DEBUG : potato: Unchanged skipping 2025/06/19 06:53:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for renames to finish 2025/06/19 06:53:50 INFO : yam: Copied (server-side copy) to: yaml 2025/06/19 06:53:50 INFO : yam: Deleted 2025/06/19 06:53:50 INFO : yaml: Renamed from "yam" 2025/06/19 06:53:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:53:50 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (12.07s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:1650: Can track renames: true 2025/06/19 06:53:51 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Making map for --track-renames 2025/06/19 06:53:51 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Finished making map for --track-renames 2025/06/19 06:53:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:53:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for renames to finish 2025/06/19 06:53:51 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/19 06:53:51 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/06/19 06:53:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:53:51 DEBUG : potato: md5 = 264f4a5324b79f0c24bfad1ea6174f6e OK 2025/06/19 06:53:51 INFO : potato: Copied (new) 2025/06/19 06:53:56 DEBUG : sub/yam: md5 = 543f8c71a08fd438d510e574244a46ca OK 2025/06/19 06:53:56 INFO : sub/yam: Copied (new) 2025/06/19 06:53:56 DEBUG : Waiting for deletions to finish 2025/06/19 06:53:57 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:53:57 DEBUG : potato: Unchanged skipping 2025/06/19 06:53:57 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Making map for --track-renames 2025/06/19 06:53:57 INFO : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Finished making map for --track-renames 2025/06/19 06:53:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:53:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for renames to finish 2025/06/19 06:54:12 INFO : sub/yam: Copied (server-side copy) to: yam 2025/06/19 06:54:17 INFO : sub/yam: Deleted 2025/06/19 06:54:17 INFO : yam: Renamed from "sub/yam" 2025/06/19 06:54:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:54:17 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (27.28s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:54:18 DEBUG : Creating backend with remote "/tmp/rclone3234654002/dir1" 2025/06/19 06:54:18 DEBUG : Creating backend with remote "/tmp/rclone3234654002/dir2" 2025/06/19 06:54:18 DEBUG : Local file system at /tmp/rclone3234654002/dir2: Using server-side directory move 2025/06/19 06:54:18 INFO : Local file system at /tmp/rclone3234654002/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/19 06:54:18 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/06/19 06:54:18 DEBUG : Local file system at /tmp/rclone3234654002/dir2: Waiting for checks to finish 2025/06/19 06:54:18 DEBUG : Local file system at /tmp/rclone3234654002/dir2: Waiting for transfers to finish 2025/06/19 06:54:18 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.24s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:54:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:54:18 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/06/19 06:54:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:54:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:54:19 DEBUG : nested/sub dir/file: md5 = fdd7e40e2fd9f59c910cf52fc815d359 OK 2025/06/19 06:54:19 INFO : nested/sub dir/file: Copied (new) 2025/06/19 06:54:19 INFO : nested/sub dir/file: Deleted 2025/06/19 06:54:23 DEBUG : sub dir/hello world: md5 = 63500fa6c08b0b8e6bf77599c562f155 OK 2025/06/19 06:54:23 INFO : sub dir/hello world: Copied (new) 2025/06/19 06:54:23 INFO : sub dir/hello world: Deleted 2025/06/19 06:54:23 INFO : sub dir: Removing directory 2025/06/19 06:54:23 INFO : nested/sub dir: Removing directory 2025/06/19 06:54:23 INFO : nested: Removing directory 2025/06/19 06:54:23 DEBUG : Local file system at /tmp/rclone3234654002: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (16.06s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:54:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/19 06:54:34 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/06/19 06:54:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:54:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:54:35 DEBUG : nested/sub dir/file: md5 = 0a1673ac8cffac175edb9a3be82744fd OK 2025/06/19 06:54:35 INFO : nested/sub dir/file: Copied (new) 2025/06/19 06:54:35 INFO : nested/sub dir/file: Deleted 2025/06/19 06:54:39 DEBUG : sub dir/hello world: md5 = 4f7a30ff2c72af75d3558df11c3a5d40 OK 2025/06/19 06:54:39 INFO : sub dir/hello world: Copied (new) 2025/06/19 06:54:39 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (15.97s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:54:50 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/06/19 06:54:50 DEBUG : existing: Need to transfer - File not found at Destination 2025/06/19 06:54:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:54:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:54:56 DEBUG : existing-b: md5 = 046b907fe80b51ebe00abb58d5ca9bcc OK 2025/06/19 06:54:56 INFO : existing-b: Copied (new) 2025/06/19 06:54:56 INFO : existing-b: Deleted 2025/06/19 06:54:56 DEBUG : existing: md5 = 468deb403fc6997301d2f27033b5c92f OK 2025/06/19 06:54:56 INFO : existing: Copied (new) 2025/06/19 06:54:56 INFO : existing: Deleted 2025/06/19 06:55:06 DEBUG : existing: Destination exists, skipping 2025/06/19 06:55:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 06:55:06 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/06/19 06:55:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 06:55:06 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (31.40s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:55:22 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gimuxaq4riya" 2025/06/19 06:55:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gimuxaq4riya.bin" 2025/06/19 06:55:22 DEBUG : Swift container crypt path rclone-test-gimuxaq4riya.bin: Auto set use_segments_container to true 2025/06/19 06:55:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gimuxaq4riya" 2025/06/19 06:55:28 DEBUG : Swift container crypt path rclone-test-gimuxaq4riya: Auto set use_segments_container to true 2025/06/19 06:55:38 DEBUG : potato2: md5 = 78c1c4b6051ee943032b0c347f7a0b49 OK 2025/06/19 06:55:43 DEBUG : empty space: md5 = 4a8818ddb86a41cca79f38a15fbe6615 OK 2025/06/19 06:55:48 DEBUG : potato3: md5 = e5251169963a51aeb5cd87ce10059820 OK sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi' -> Encrypted drive 'TestCryptSwift:rclone-test-gimuxaq4riya' 2025/06/19 06:55:50 DEBUG : empty space: md5 = cf2eb0a09d4a254badbd070184a05bac OK 2025/06/19 06:55:50 DEBUG : potato3: md5 = 940d8d72ef156b68251193844733a9de OK 2025/06/19 06:55:50 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:55:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gimuxaq4riya': Waiting for checks to finish 2025/06/19 06:55:50 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/19 06:55:56 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:55:56 DEBUG : empty space: Unchanged skipping 2025/06/19 06:55:56 INFO : potato2: Copied (server-side copy) 2025/06/19 06:56:01 INFO : empty space: Deleted 2025/06/19 06:56:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gimuxaq4riya': Waiting for transfers to finish 2025/06/19 06:56:01 INFO : potato3: Copied (server-side copy) 2025/06/19 06:56:01 INFO : potato2: Deleted 2025/06/19 06:56:06 INFO : potato3: Deleted 2025/06/19 06:56:06 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gaduxas9jiyu" 2025/06/19 06:56:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gaduxas9jiyu.bin" 2025/06/19 06:56:07 DEBUG : Swift container crypt path rclone-test-gaduxas9jiyu.bin: Auto set use_segments_container to true 2025/06/19 06:56:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gaduxas9jiyu" 2025/06/19 06:56:12 DEBUG : Swift container crypt path rclone-test-gaduxas9jiyu: Auto set use_segments_container to true 2025/06/19 06:56:23 DEBUG : empty space: Need to transfer - File not found at Destination 2025/06/19 06:56:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:56:23 DEBUG : potato3: Need to transfer - File not found at Destination 2025/06/19 06:56:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gaduxas9jiyu': Waiting for checks to finish 2025/06/19 06:56:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gaduxas9jiyu': Waiting for transfers to finish 2025/06/19 06:56:28 INFO : empty space: Copied (server-side copy) 2025/06/19 06:56:28 INFO : potato2: Copied (server-side copy) 2025/06/19 06:56:28 INFO : potato3: Copied (server-side copy) 2025/06/19 06:56:28 INFO : potato2: Deleted 2025/06/19 06:56:28 INFO : potato3: Deleted 2025/06/19 06:56:29 INFO : empty space: Deleted 2025/06/19 06:56:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gaduxas9jiyu': Purge remote 2025/06/19 06:56:29 DEBUG : Waiting for deletions to finish 2025/06/19 06:56:29 INFO : potato3.bin: Deleted 2025/06/19 06:56:29 INFO : potato2.bin: Deleted 2025/06/19 06:56:29 INFO : empty space.bin: Deleted 2025/06/19 06:56:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gimuxaq4riya': Purge remote 2025/06/19 06:56:29 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (67.99s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:56:30 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wateyis1cera" 2025/06/19 06:56:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wateyis1cera.bin" 2025/06/19 06:56:30 DEBUG : Swift container crypt path rclone-test-wateyis1cera.bin: Auto set use_segments_container to true 2025/06/19 06:56:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wateyis1cera" 2025/06/19 06:56:36 DEBUG : Swift container crypt path rclone-test-wateyis1cera: Auto set use_segments_container to true 2025/06/19 06:56:46 DEBUG : potato2: md5 = f6d24274660c183de614904a5952ce8b OK 2025/06/19 06:56:51 DEBUG : empty space: md5 = 1762fdb67dea85927db774880a5eefe2 OK 2025/06/19 06:56:56 DEBUG : potato3: md5 = a39115fe13dc95dcb2bcda2e69212688 OK sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi' -> Encrypted drive 'TestCryptSwift:rclone-test-wateyis1cera' 2025/06/19 06:57:07 DEBUG : empty space: md5 = 94b877bc166ad266f03ae0ebcf0cf252 OK 2025/06/19 06:57:12 DEBUG : potato3: md5 = 3947165b80aa35233f58502af40e10ec OK 2025/06/19 06:57:23 DEBUG : empty space: Excluded (Size Filter) 2025/06/19 06:57:23 DEBUG : empty space: Excluded 2025/06/19 06:57:23 DEBUG : empty space: Excluded (Size Filter) 2025/06/19 06:57:23 DEBUG : empty space: Excluded 2025/06/19 06:57:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:57:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wateyis1cera': Waiting for checks to finish 2025/06/19 06:57:23 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/19 06:57:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wateyis1cera': Waiting for transfers to finish 2025/06/19 06:57:28 INFO : potato2: Copied (server-side copy) 2025/06/19 06:57:33 INFO : potato2: Deleted 2025/06/19 06:57:38 INFO : potato3: Copied (server-side copy) 2025/06/19 06:57:43 INFO : potato3: Deleted 2025/06/19 06:57:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wupeqap7kaju" 2025/06/19 06:57:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wupeqap7kaju.bin" 2025/06/19 06:57:54 DEBUG : Swift container crypt path rclone-test-wupeqap7kaju.bin: Auto set use_segments_container to true 2025/06/19 06:57:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wupeqap7kaju" 2025/06/19 06:57:59 DEBUG : Swift container crypt path rclone-test-wupeqap7kaju: Auto set use_segments_container to true 2025/06/19 06:58:05 DEBUG : empty space: Excluded (Size Filter) 2025/06/19 06:58:05 DEBUG : empty space: Excluded 2025/06/19 06:58:05 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:58:05 DEBUG : potato3: Need to transfer - File not found at Destination 2025/06/19 06:58:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wupeqap7kaju': Waiting for checks to finish 2025/06/19 06:58:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wupeqap7kaju': Waiting for transfers to finish 2025/06/19 06:58:15 INFO : potato2: Copied (server-side copy) 2025/06/19 06:58:15 INFO : potato2: Deleted 2025/06/19 06:58:15 INFO : potato3: Copied (server-side copy) 2025/06/19 06:58:20 INFO : potato3: Deleted 2025/06/19 06:58:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wupeqap7kaju': Purge remote 2025/06/19 06:58:21 DEBUG : Waiting for deletions to finish 2025/06/19 06:58:26 INFO : potato2.bin: Deleted 2025/06/19 06:58:31 INFO : potato3.bin: Deleted 2025/06/19 06:58:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wateyis1cera': Purge remote 2025/06/19 06:58:31 DEBUG : Waiting for deletions to finish 2025/06/19 06:58:36 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (131.99s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 06:58:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yamaveq9xawo" 2025/06/19 06:58:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yamaveq9xawo.bin" 2025/06/19 06:58:42 DEBUG : Swift container crypt path rclone-test-yamaveq9xawo.bin: Auto set use_segments_container to true 2025/06/19 06:58:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yamaveq9xawo" 2025/06/19 06:58:48 DEBUG : Swift container crypt path rclone-test-yamaveq9xawo: Auto set use_segments_container to true 2025/06/19 06:58:58 DEBUG : potato2: md5 = 1aacc16a50b41cd4c9e9a7c9f1304f21 OK 2025/06/19 06:59:03 DEBUG : empty space: md5 = 52ea743bdc53898a38d98350b8e19573 OK 2025/06/19 06:59:08 DEBUG : potato3: md5 = 6733e0bf517cd47bf65d50c26d7a3ac6 OK 2025/06/19 06:59:08 INFO : tomatoDir: Making directory sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi' -> Encrypted drive 'TestCryptSwift:rclone-test-yamaveq9xawo' 2025/06/19 06:59:14 DEBUG : empty space: md5 = 19db3bc63f75ac8b2adb99fcf6f00e83 OK 2025/06/19 06:59:14 DEBUG : potato3: md5 = 1d2a8eb3c3020a40cf36d2b3ed0544c7 OK 2025/06/19 06:59:15 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:59:15 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/19 06:59:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yamaveq9xawo': Waiting for checks to finish 2025/06/19 06:59:15 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:59:15 DEBUG : empty space: Unchanged skipping 2025/06/19 06:59:20 INFO : empty space: Deleted 2025/06/19 06:59:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yamaveq9xawo': Waiting for transfers to finish 2025/06/19 06:59:20 INFO : potato3: Copied (server-side copy) 2025/06/19 06:59:21 INFO : potato2: Copied (server-side copy) 2025/06/19 06:59:25 INFO : potato3: Deleted 2025/06/19 06:59:26 INFO : potato2: Deleted 2025/06/19 06:59:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-cohasiv0lutu" 2025/06/19 06:59:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-cohasiv0lutu.bin" 2025/06/19 06:59:27 DEBUG : Swift container crypt path rclone-test-cohasiv0lutu.bin: Auto set use_segments_container to true 2025/06/19 06:59:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-cohasiv0lutu" 2025/06/19 06:59:32 DEBUG : Swift container crypt path rclone-test-cohasiv0lutu: Auto set use_segments_container to true 2025/06/19 06:59:38 INFO : tomatoDir: Making directory 2025/06/19 06:59:38 DEBUG : empty space: Need to transfer - File not found at Destination 2025/06/19 06:59:38 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/19 06:59:38 DEBUG : potato3: Need to transfer - File not found at Destination 2025/06/19 06:59:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-cohasiv0lutu': Waiting for checks to finish 2025/06/19 06:59:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-cohasiv0lutu': Waiting for transfers to finish 2025/06/19 06:59:48 INFO : potato2: Copied (server-side copy) 2025/06/19 06:59:48 INFO : potato2: Deleted 2025/06/19 06:59:48 INFO : potato3: Copied (server-side copy) 2025/06/19 06:59:48 INFO : potato3: Deleted 2025/06/19 06:59:54 INFO : empty space: Copied (server-side copy) 2025/06/19 06:59:54 INFO : empty space: Deleted 2025/06/19 06:59:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-cohasiv0lutu': Purge remote 2025/06/19 06:59:59 DEBUG : Waiting for deletions to finish 2025/06/19 07:00:04 INFO : potato2.bin: Deleted 2025/06/19 07:00:05 INFO : potato3.bin: Deleted 2025/06/19 07:00:09 INFO : empty space.bin: Deleted 2025/06/19 07:00:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yamaveq9xawo': Purge remote 2025/06/19 07:00:09 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (88.10s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:00:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/rclone-move-test" 2025/06/19 07:00:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-move-test.bin" 2025/06/19 07:00:10 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-move-test.bin: Auto set use_segments_container to true 2025/06/19 07:00:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-move-test" 2025/06/19 07:00:16 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-move-test: Auto set use_segments_container to true 2025/06/19 07:00:26 DEBUG : potato2: md5 = 891a31342d0a646c8e57a9f4586aca83 OK --- PASS: TestServerSideMoveOverlap (26.95s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:00:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test" 2025/06/19 07:00:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-sync-test.bin" 2025/06/19 07:00:37 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-sync-test.bin: Auto set use_segments_container to true 2025/06/19 07:00:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-sync-test" 2025/06/19 07:00:43 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-sync-test: Auto set use_segments_container to true --- PASS: TestSyncOverlap (11.57s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:00:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test" 2025/06/19 07:00:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-sync-test.bin" 2025/06/19 07:00:49 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-sync-test.bin: Auto set use_segments_container to true 2025/06/19 07:00:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-sync-test" 2025/06/19 07:00:54 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-sync-test: Auto set use_segments_container to true 2025/06/19 07:00:59 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test-include/layer2" 2025/06/19 07:00:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-sync-test-include/layer2.bin" 2025/06/19 07:01:00 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/06/19 07:01:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-sync-test-include/layer2" 2025/06/19 07:01:05 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/06/19 07:01:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test-ignore-file" 2025/06/19 07:01:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-sync-test-ignore-file.bin" 2025/06/19 07:01:11 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/06/19 07:01:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/rclone-sync-test-ignore-file" 2025/06/19 07:01:17 DEBUG : Swift container crypt path rclone-test-majesad5gepi/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/06/19 07:01:23 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = ed959f8fc12ed0eff969564d33406a8d OK 2025/06/19 07:01:28 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/19 07:01:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test': Waiting for checks to finish 2025/06/19 07:01:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test': Waiting for transfers to finish 2025/06/19 07:01:28 DEBUG : Waiting for deletions to finish 2025/06/19 07:01:28 INFO : There was nothing to transfer 2025/06/19 07:01:33 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/19 07:01:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:01:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:01:33 DEBUG : Waiting for deletions to finish 2025/06/19 07:01:33 INFO : There was nothing to transfer 2025/06/19 07:01:38 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/19 07:01:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/06/19 07:01:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/06/19 07:01:38 DEBUG : Waiting for deletions to finish 2025/06/19 07:01:38 INFO : There was nothing to transfer 2025/06/19 07:01:44 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/19 07:01:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:01:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:01:44 DEBUG : Waiting for deletions to finish 2025/06/19 07:01:44 INFO : There was nothing to transfer 2025/06/19 07:01:44 DEBUG : Excluded 2025/06/19 07:01:44 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/19 07:01:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/06/19 07:01:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/06/19 07:01:44 DEBUG : Waiting for deletions to finish 2025/06/19 07:01:44 INFO : There was nothing to transfer --- PASS: TestSyncOverlapWithFilter (55.88s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:01:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/dst" 2025/06/19 07:01:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst.bin" 2025/06/19 07:01:44 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst.bin: Auto set use_segments_container to true 2025/06/19 07:01:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst" 2025/06/19 07:01:50 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst: Auto set use_segments_container to true 2025/06/19 07:01:56 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/CompareDest" 2025/06/19 07:01:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/CompareDest.bin" 2025/06/19 07:01:56 DEBUG : Swift container crypt path rclone-test-majesad5gepi/CompareDest.bin: Auto set use_segments_container to true 2025/06/19 07:02:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/CompareDest" 2025/06/19 07:02:02 DEBUG : Swift container crypt path rclone-test-majesad5gepi/CompareDest: Auto set use_segments_container to true 2025/06/19 07:02:12 DEBUG : one: Need to transfer - File not found at Destination 2025/06/19 07:02:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:02:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:02:18 DEBUG : one: md5 = a7945d9b1e8b7d80d892b7145a9801bf OK 2025/06/19 07:02:18 INFO : one: Copied (new) 2025/06/19 07:02:18 DEBUG : Waiting for deletions to finish 2025/06/19 07:02:19 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 07:02:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:02:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:02:29 DEBUG : one: md5 = 790ff595c33287ff14e41e67a12f196b OK 2025/06/19 07:02:29 INFO : one: Copied (replaced existing) 2025/06/19 07:02:29 DEBUG : Waiting for deletions to finish 2025/06/19 07:02:40 DEBUG : dst/one: md5 = 5b2d3b62dcb721dfc3bea8669cf2e90d OK 2025/06/19 07:02:40 DEBUG : CompareDest/one: md5 = 706d6ddbe03877648573147ffd2f3243 OK 2025/06/19 07:02:40 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 07:02:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:02:40 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:02:40 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/19 07:02:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:02:40 DEBUG : Waiting for deletions to finish 2025/06/19 07:02:40 INFO : There was nothing to transfer 2025/06/19 07:02:46 DEBUG : CompareDest/two: md5 = cc0e80ab50de2ded4aabcfe8b4ee78e3 OK 2025/06/19 07:02:51 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 07:02:51 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:02:51 DEBUG : two: Destination found in --compare-dest, skipping 2025/06/19 07:02:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:02:51 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:02:51 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/19 07:02:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:02:51 DEBUG : Waiting for deletions to finish 2025/06/19 07:02:51 INFO : There was nothing to transfer 2025/06/19 07:02:52 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 07:02:52 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:02:52 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/19 07:02:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:02:52 DEBUG : two: Destination found in --compare-dest, skipping 2025/06/19 07:02:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:02:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:02:52 DEBUG : Waiting for deletions to finish 2025/06/19 07:02:52 INFO : There was nothing to transfer sync_test.go:2176: No hash on uploaded file so skipping compare timestamp test 2025/06/19 07:02:52 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 07:02:52 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/06/19 07:02:52 DEBUG : two: Need to transfer - File not found at Destination 2025/06/19 07:02:52 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:02:52 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/19 07:02:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:02:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:02:53 DEBUG : two: md5 = 0f66c881f2e1c067fa8efbee22da439d OK 2025/06/19 07:02:53 INFO : two: Copied (new) 2025/06/19 07:02:53 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (74.83s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:03:04 DEBUG : pre-dest1/1: md5 = 440715a06812056fcdbbf128fad2ecbe OK 2025/06/19 07:03:09 DEBUG : pre-dest2/2: md5 = 243cc278bf998b74aa0382295ef1f559 OK 2025/06/19 07:03:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/dest" 2025/06/19 07:03:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dest.bin" 2025/06/19 07:03:20 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dest.bin: Auto set use_segments_container to true 2025/06/19 07:03:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dest" 2025/06/19 07:03:26 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dest: Auto set use_segments_container to true 2025/06/19 07:03:31 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/pre-dest1" 2025/06/19 07:03:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/pre-dest1.bin" 2025/06/19 07:03:31 DEBUG : Swift container crypt path rclone-test-majesad5gepi/pre-dest1.bin: Auto set use_segments_container to true 2025/06/19 07:03:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/pre-dest1" 2025/06/19 07:03:37 DEBUG : Swift container crypt path rclone-test-majesad5gepi/pre-dest1: Auto set use_segments_container to true 2025/06/19 07:03:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/pre-dest2" 2025/06/19 07:03:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/pre-dest2.bin" 2025/06/19 07:03:43 DEBUG : Swift container crypt path rclone-test-majesad5gepi/pre-dest2.bin: Auto set use_segments_container to true 2025/06/19 07:03:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/pre-dest2" 2025/06/19 07:03:48 DEBUG : Swift container crypt path rclone-test-majesad5gepi/pre-dest2: Auto set use_segments_container to true 2025/06/19 07:03:54 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:03:54 DEBUG : 1: Destination found in --compare-dest, skipping 2025/06/19 07:03:59 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:03:59 DEBUG : 2: Destination found in --compare-dest, skipping 2025/06/19 07:04:10 DEBUG : 3: Need to transfer - File not found at Destination 2025/06/19 07:04:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dest': Waiting for checks to finish 2025/06/19 07:04:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dest': Waiting for transfers to finish 2025/06/19 07:04:10 DEBUG : 3: md5 = 53e03b3a8f624d79b4f93f77215a5b2f OK 2025/06/19 07:04:10 INFO : 3: Copied (new) 2025/06/19 07:04:10 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (87.11s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:04:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/dst" 2025/06/19 07:04:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst.bin" 2025/06/19 07:04:26 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst.bin: Auto set use_segments_container to true 2025/06/19 07:04:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst" 2025/06/19 07:04:32 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst: Auto set use_segments_container to true 2025/06/19 07:04:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/CopyDest" 2025/06/19 07:04:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/CopyDest.bin" 2025/06/19 07:04:38 DEBUG : Swift container crypt path rclone-test-majesad5gepi/CopyDest.bin: Auto set use_segments_container to true 2025/06/19 07:04:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/CopyDest" 2025/06/19 07:04:43 DEBUG : Swift container crypt path rclone-test-majesad5gepi/CopyDest: Auto set use_segments_container to true 2025/06/19 07:04:54 DEBUG : one: Need to transfer - File not found at Destination 2025/06/19 07:04:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:04:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:04:59 DEBUG : one: md5 = 775171f2ff527974ae0a7ce77617d212 OK 2025/06/19 07:04:59 INFO : one: Copied (new) 2025/06/19 07:04:59 DEBUG : Waiting for deletions to finish 2025/06/19 07:05:09 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 07:05:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:05:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:05:20 DEBUG : one: md5 = 695c49cea5e04eb33a965ad03ba6de09 OK 2025/06/19 07:05:20 INFO : one: Copied (replaced existing) 2025/06/19 07:05:20 DEBUG : Waiting for deletions to finish 2025/06/19 07:05:25 DEBUG : dst/one: md5 = f2def3dd38612fafb9b3d1072074a19c OK 2025/06/19 07:05:25 DEBUG : CopyDest/one: md5 = 5c49de41fd75beafb03f50d2c918a813 OK 2025/06/19 07:05:31 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/BackupDir" 2025/06/19 07:05:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/BackupDir.bin" 2025/06/19 07:05:31 DEBUG : Swift container crypt path rclone-test-majesad5gepi/BackupDir.bin: Auto set use_segments_container to true 2025/06/19 07:05:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/BackupDir" 2025/06/19 07:05:37 DEBUG : Swift container crypt path rclone-test-majesad5gepi/BackupDir: Auto set use_segments_container to true 2025/06/19 07:05:42 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 07:05:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:05:42 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:05:42 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 07:05:58 INFO : one: Copied (server-side copy) 2025/06/19 07:06:03 INFO : one: Deleted 2025/06/19 07:06:13 INFO : one: Copied (server-side copy) 2025/06/19 07:06:13 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/06/19 07:06:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:06:13 DEBUG : Waiting for deletions to finish 2025/06/19 07:06:19 DEBUG : CopyDest/two: md5 = e961e8a483e0e28bd24e747e10a04401 OK 2025/06/19 07:06:24 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:06:24 DEBUG : one: Unchanged skipping 2025/06/19 07:06:24 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:06:30 INFO : two: Copied (server-side copy) 2025/06/19 07:06:30 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/06/19 07:06:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:06:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:06:30 DEBUG : Waiting for deletions to finish 2025/06/19 07:06:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:06:35 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:06:35 DEBUG : two: Unchanged skipping 2025/06/19 07:06:40 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:06:40 DEBUG : one: Unchanged skipping 2025/06/19 07:06:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:06:40 DEBUG : Waiting for deletions to finish 2025/06/19 07:06:40 INFO : There was nothing to transfer 2025/06/19 07:06:51 DEBUG : CopyDest/three: md5 = 706ab49c4fd1c44b7a2fcbc41ca28c7f OK 2025/06/19 07:06:51 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:06:51 DEBUG : one: Unchanged skipping 2025/06/19 07:06:51 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/06/19 07:06:51 DEBUG : three: Destination not found in --copy-dest 2025/06/19 07:06:51 DEBUG : three: Need to transfer - File not found at Destination 2025/06/19 07:06:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:06:51 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:06:51 DEBUG : two: Unchanged skipping 2025/06/19 07:06:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:06:57 DEBUG : three: md5 = 2bcfd07ed1018321815291b8ca3f0f36 OK 2025/06/19 07:06:57 INFO : three: Copied (new) 2025/06/19 07:06:57 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (182.87s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:07:34 DEBUG : dst/one: md5 = 0aaa4001dcfeff8d4c94f788434931f4 OK 2025/06/19 07:07:34 DEBUG : dst/two: md5 = b1e12fde1351d5abcb174b126a06ab18 OK 2025/06/19 07:07:35 DEBUG : dst/three.txt: md5 = 15f806bb52577381c647af883a888a5c OK 2025/06/19 07:07:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/dst" 2025/06/19 07:07:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst.bin" 2025/06/19 07:07:35 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst.bin: Auto set use_segments_container to true 2025/06/19 07:07:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst" 2025/06/19 07:07:41 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst: Auto set use_segments_container to true 2025/06/19 07:07:46 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/backup" 2025/06/19 07:07:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/backup.bin" 2025/06/19 07:07:46 DEBUG : Swift container crypt path rclone-test-majesad5gepi/backup.bin: Auto set use_segments_container to true 2025/06/19 07:07:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/backup" 2025/06/19 07:07:52 DEBUG : Swift container crypt path rclone-test-majesad5gepi/backup: Auto set use_segments_container to true 2025/06/19 07:07:57 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/19 07:07:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:07:58 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:07:58 DEBUG : two: Unchanged skipping 2025/06/19 07:08:18 INFO : one: Copied (server-side copy) 2025/06/19 07:08:23 INFO : one: Deleted 2025/06/19 07:08:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:08:28 DEBUG : one: md5 = 1ffc5316daefa207205c53e4cef1f1e2 OK 2025/06/19 07:08:28 INFO : one: Copied (new) 2025/06/19 07:08:28 DEBUG : Waiting for deletions to finish 2025/06/19 07:08:39 INFO : three.txt: Copied (server-side copy) 2025/06/19 07:08:39 INFO : three.txt: Deleted 2025/06/19 07:08:39 INFO : three.txt: Moved into backup dir 2025/06/19 07:08:39 DEBUG : dst/three.txt: md5 = ec4fb5858deb75e6654feff5d2d705a1 OK 2025/06/19 07:08:40 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/19 07:08:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:08:40 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:08:40 DEBUG : two: Unchanged skipping 2025/06/19 07:08:55 INFO : one: Copied (server-side copy) 2025/06/19 07:09:00 INFO : one: Deleted 2025/06/19 07:09:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:09:05 DEBUG : one: md5 = 9c396f4f04bfcdd37f220a2f2682c108 OK 2025/06/19 07:09:05 INFO : one: Copied (new) 2025/06/19 07:09:05 DEBUG : Waiting for deletions to finish 2025/06/19 07:09:11 INFO : three.txt: Copied (server-side copy) 2025/06/19 07:09:11 INFO : three.txt: Deleted 2025/06/19 07:09:11 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (123.10s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:09:37 DEBUG : dst/one: md5 = 3fb4768fd4a7c613a323a7c597e73441 OK 2025/06/19 07:09:37 DEBUG : dst/two: md5 = 949848ab023f6abcaadfc2f8d56609c2 OK 2025/06/19 07:09:38 DEBUG : dst/three.txt: md5 = 836ef70f0e70ea387e304dd39204e0e4 OK 2025/06/19 07:09:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/dst" 2025/06/19 07:09:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst.bin" 2025/06/19 07:09:44 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst.bin: Auto set use_segments_container to true 2025/06/19 07:09:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst" 2025/06/19 07:09:50 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst: Auto set use_segments_container to true 2025/06/19 07:09:55 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/backup" 2025/06/19 07:09:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/backup.bin" 2025/06/19 07:09:55 DEBUG : Swift container crypt path rclone-test-majesad5gepi/backup.bin: Auto set use_segments_container to true 2025/06/19 07:10:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/backup" 2025/06/19 07:10:01 DEBUG : Swift container crypt path rclone-test-majesad5gepi/backup: Auto set use_segments_container to true 2025/06/19 07:10:06 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/19 07:10:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:10:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:10:06 DEBUG : two: Unchanged skipping 2025/06/19 07:10:17 INFO : one: Copied (server-side copy) to: one.bak 2025/06/19 07:10:22 INFO : one: Deleted 2025/06/19 07:10:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:10:27 DEBUG : one: md5 = c9c802e1399e988698ba7b46a3686b25 OK 2025/06/19 07:10:27 INFO : one: Copied (new) 2025/06/19 07:10:27 DEBUG : Waiting for deletions to finish 2025/06/19 07:10:43 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/19 07:10:43 INFO : three.txt: Deleted 2025/06/19 07:10:43 INFO : three.txt: Moved into backup dir 2025/06/19 07:10:43 DEBUG : dst/three.txt: md5 = a2f00e0139a7d0c4973aad62a9e7089e OK 2025/06/19 07:10:44 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/19 07:10:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:10:44 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:10:44 DEBUG : two: Unchanged skipping 2025/06/19 07:10:49 INFO : one: Copied (server-side copy) to: one.bak 2025/06/19 07:10:54 INFO : one: Deleted 2025/06/19 07:10:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:10:59 DEBUG : one: md5 = e4b2bf59f8be11d57d09a14d78c08869 OK 2025/06/19 07:10:59 INFO : one: Copied (new) 2025/06/19 07:10:59 DEBUG : Waiting for deletions to finish 2025/06/19 07:11:10 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/19 07:11:10 INFO : three.txt: Deleted 2025/06/19 07:11:10 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (119.22s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:11:37 DEBUG : dst/one: md5 = fb23ee75e0c0b4cc17e4a1396acdfa60 OK 2025/06/19 07:11:37 DEBUG : dst/two: md5 = 93b94d18ea9d033f8ba22cf9660544fc OK 2025/06/19 07:11:37 DEBUG : dst/three.txt: md5 = e2ac5c15a640e3503503b08465293a35 OK 2025/06/19 07:11:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/dst" 2025/06/19 07:11:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst.bin" 2025/06/19 07:11:38 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst.bin: Auto set use_segments_container to true 2025/06/19 07:11:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst" 2025/06/19 07:11:43 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst: Auto set use_segments_container to true 2025/06/19 07:11:49 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/backup" 2025/06/19 07:11:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/backup.bin" 2025/06/19 07:11:49 DEBUG : Swift container crypt path rclone-test-majesad5gepi/backup.bin: Auto set use_segments_container to true 2025/06/19 07:11:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/backup" 2025/06/19 07:11:54 DEBUG : Swift container crypt path rclone-test-majesad5gepi/backup: Auto set use_segments_container to true 2025/06/19 07:12:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:12:00 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/19 07:12:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:12:00 DEBUG : two: Unchanged skipping 2025/06/19 07:12:32 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/06/19 07:12:37 INFO : one: Deleted 2025/06/19 07:12:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:12:42 DEBUG : one: md5 = 51e7f134919cc63866732972d52fa77a OK 2025/06/19 07:12:42 INFO : one: Copied (new) 2025/06/19 07:12:42 DEBUG : Waiting for deletions to finish 2025/06/19 07:13:03 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/06/19 07:13:03 INFO : three.txt: Deleted 2025/06/19 07:13:03 INFO : three.txt: Moved into backup dir 2025/06/19 07:13:08 DEBUG : dst/three.txt: md5 = 080565db0b4b334b12b115cf997ae664 OK 2025/06/19 07:13:24 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/19 07:13:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:13:24 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:13:24 DEBUG : two: Unchanged skipping 2025/06/19 07:13:39 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/06/19 07:13:44 INFO : one: Deleted 2025/06/19 07:13:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:13:49 DEBUG : one: md5 = a09e5bccedccce1e8c5f70211a26977d OK 2025/06/19 07:13:49 INFO : one: Copied (new) 2025/06/19 07:13:49 DEBUG : Waiting for deletions to finish 2025/06/19 07:14:04 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/06/19 07:14:04 INFO : three.txt: Deleted 2025/06/19 07:14:04 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (184.70s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:14:41 DEBUG : dst/one: md5 = dcc1808d63829fbdf4536c8d3863c177 OK 2025/06/19 07:14:41 DEBUG : dst/two: md5 = 7eb2ea31e9b8d89535df2b8534ca06fa OK 2025/06/19 07:14:42 DEBUG : dst/three.txt: md5 = 5e4bd47ab50176e725e1e4a704470997 OK 2025/06/19 07:14:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/dst" 2025/06/19 07:14:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst.bin" 2025/06/19 07:14:42 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst.bin: Auto set use_segments_container to true 2025/06/19 07:14:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst" 2025/06/19 07:14:48 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst: Auto set use_segments_container to true 2025/06/19 07:14:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:14:53 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/19 07:14:53 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:14:53 DEBUG : two: Unchanged skipping 2025/06/19 07:15:04 INFO : one: Copied (server-side copy) to: one.bak 2025/06/19 07:15:09 INFO : one: Deleted 2025/06/19 07:15:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:15:14 DEBUG : one: md5 = 0a9364b290b18a87e21b3ed85808fa7d OK 2025/06/19 07:15:14 INFO : one: Copied (new) 2025/06/19 07:15:14 DEBUG : Waiting for deletions to finish 2025/06/19 07:15:35 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/19 07:15:35 INFO : three.txt: Deleted 2025/06/19 07:15:35 INFO : three.txt: Moved into backup dir 2025/06/19 07:15:45 DEBUG : dst/three.txt: md5 = 03e0fa4e8207819f97d1df78412c8e0b OK 2025/06/19 07:15:51 DEBUG : one.bak: Excluded (Path Filter) 2025/06/19 07:15:51 DEBUG : one.bak: Excluded 2025/06/19 07:15:51 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/06/19 07:15:51 DEBUG : three.txt.bak: Excluded 2025/06/19 07:15:51 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/19 07:15:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for checks to finish 2025/06/19 07:15:51 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:15:51 DEBUG : two: Unchanged skipping 2025/06/19 07:15:56 INFO : one: Copied (server-side copy) to: one.bak 2025/06/19 07:16:01 INFO : one: Deleted 2025/06/19 07:16:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi/dst': Waiting for transfers to finish 2025/06/19 07:16:07 DEBUG : one: md5 = 8e3215f9cab6c4ea760f08d0d4510ac9 OK 2025/06/19 07:16:07 INFO : one: Copied (new) 2025/06/19 07:16:07 DEBUG : Waiting for deletions to finish 2025/06/19 07:16:22 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/19 07:16:22 INFO : three.txt: Deleted 2025/06/19 07:16:22 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (127.49s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:16:49 DEBUG : dst/one: md5 = d31bca3c1fcb0f3ffaf68ed1a7ec13c6 OK 2025/06/19 07:16:49 DEBUG : dst/two: md5 = 0af4ac0bfe438fc59899dd43849289c4 OK 2025/06/19 07:16:49 DEBUG : dst/three.txt: md5 = 51eababa7931f78c452c75bd50470df9 OK 2025/06/19 07:16:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/dst" 2025/06/19 07:16:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst.bin" 2025/06/19 07:16:55 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst.bin: Auto set use_segments_container to true 2025/06/19 07:17:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst" 2025/06/19 07:17:00 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst: Auto set use_segments_container to true 2025/06/19 07:17:10 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/19 07:17:21 INFO : one: Copied (server-side copy) to: one.bak 2025/06/19 07:17:26 INFO : one: Deleted 2025/06/19 07:17:31 DEBUG : one: md5 = 46f851a1e17c0ae04c8765e60459af62 OK 2025/06/19 07:17:31 INFO : one: Copied (new) 2025/06/19 07:17:31 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:17:31 DEBUG : two: Unchanged skipping 2025/06/19 07:17:31 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/06/19 07:17:57 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/19 07:17:57 INFO : three.txt: Deleted 2025/06/19 07:17:57 DEBUG : three.txt: md5 = 4a47dc0ed29d0b605c777a594bf94b82 OK 2025/06/19 07:17:57 INFO : three.txt: Copied (new) 2025/06/19 07:18:12 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/19 07:18:18 INFO : one: Copied (server-side copy) to: one.bak 2025/06/19 07:18:23 INFO : one: Deleted 2025/06/19 07:18:28 DEBUG : one: md5 = 0242b188669921245f41ff669a891838 OK 2025/06/19 07:18:28 INFO : one: Copied (new) 2025/06/19 07:18:28 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:18:28 DEBUG : two: Unchanged skipping 2025/06/19 07:18:28 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/06/19 07:18:44 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/19 07:18:44 INFO : three.txt: Deleted 2025/06/19 07:18:44 DEBUG : three.txt: md5 = e8ef07408de86dd5c3bd23548404d020 OK 2025/06/19 07:18:44 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (142.37s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:19:11 DEBUG : dst/one: md5 = 6564b2daece5ed6808fdecb9a13e3d1b OK 2025/06/19 07:19:11 DEBUG : dst/two: md5 = 0f72fb6c6027d5d61dcad7274a99a0b7 OK 2025/06/19 07:19:11 DEBUG : dst/three.txt: md5 = b2cc36fae01e8c4b53d0310d1e13d068 OK 2025/06/19 07:19:12 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-majesad5gepi/dst" 2025/06/19 07:19:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst.bin" 2025/06/19 07:19:12 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst.bin: Auto set use_segments_container to true 2025/06/19 07:19:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-majesad5gepi/dst" 2025/06/19 07:19:18 DEBUG : Swift container crypt path rclone-test-majesad5gepi/dst: Auto set use_segments_container to true 2025/06/19 07:19:23 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/19 07:19:34 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/06/19 07:19:39 INFO : one: Deleted 2025/06/19 07:19:44 DEBUG : one: md5 = ec933d410205b91c959e49799c5eeda4 OK 2025/06/19 07:19:44 INFO : one: Copied (new) 2025/06/19 07:19:44 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:19:44 DEBUG : two: Unchanged skipping 2025/06/19 07:19:44 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/06/19 07:20:00 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/06/19 07:20:00 INFO : three.txt: Deleted 2025/06/19 07:20:00 DEBUG : three.txt: md5 = 8d5d32ce02381fd7cadc04adb2980145 OK 2025/06/19 07:20:00 INFO : three.txt: Copied (new) 2025/06/19 07:20:01 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/19 07:20:06 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/06/19 07:20:11 INFO : one: Deleted 2025/06/19 07:20:16 DEBUG : one: md5 = 58c5715b09062755002da935de57bca5 OK 2025/06/19 07:20:16 INFO : one: Copied (new) 2025/06/19 07:20:16 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:20:16 DEBUG : two: Unchanged skipping 2025/06/19 07:20:16 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/06/19 07:20:32 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/06/19 07:20:32 INFO : three.txt: Deleted 2025/06/19 07:20:32 DEBUG : three.txt: md5 = d5076ba53ca9e960e7cb869e780ef2b8 OK 2025/06/19 07:20:32 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (107.51s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:20:54 DEBUG : Testêé: md5 = edfcb3af64f1a7109a872dfa0bcf187d OK 2025/06/19 07:20:54 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/06/19 07:20:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:20:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:20:54 DEBUG : Testêé: md5 = 7ccd8acbd9eb15b7b609e986595a0e00 OK 2025/06/19 07:20:54 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/06/19 07:20:54 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (1.65s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:20:55 DEBUG : existing: Need to transfer - File not found at Destination 2025/06/19 07:20:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:20:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:21:00 DEBUG : existing: md5 = 8a36b2e77672c43a26fdbc81e1b3a202 OK 2025/06/19 07:21:00 INFO : existing: Copied (new) 2025/06/19 07:21:00 DEBUG : Waiting for deletions to finish 2025/06/19 07:21:01 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/06/19 07:21:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:21:01 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/06/19 07:21:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:21:01 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': not deleting files as there were IO errors 2025/06/19 07:21:01 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': not deleting directories as there were IO errors --- PASS: TestSyncImmutable (16.35s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:21:12 DEBUG : EXISTING: md5 = 1cb5f4c0e162eb3ef67388c35bb211de OK 2025/06/19 07:21:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:21:12 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:21:12 DEBUG : existing: Unchanged skipping 2025/06/19 07:21:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:21:12 DEBUG : Waiting for deletions to finish 2025/06/19 07:21:12 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.24s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:2636: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.20s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:2675: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:2675: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" sync_test.go:2675: This test only runs on local --- PASS: TestMaxTransfer (0.41s) --- SKIP: TestMaxTransfer/Hard (0.22s) --- SKIP: TestMaxTransfer/Soft (0.10s) --- SKIP: TestMaxTransfer/Cautious (0.10s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:21:19 DEBUG : both0: md5 = 1e99c6a8271dd8a1f901b02d880caf5f OK 2025/06/19 07:21:24 DEBUG : only0: md5 = 85045b6e53f472a9f2e87ea8df35cdcf OK 2025/06/19 07:21:32 DEBUG : both1: md5 = 8780b2526b04a21d9fdce98c0a516fe1 OK 2025/06/19 07:21:38 DEBUG : only1: md5 = 1128c7ba707742d8210dd69af33cf96f OK 2025/06/19 07:21:43 DEBUG : both2: md5 = c8f14f0604c02acc53293581023f4211 OK 2025/06/19 07:21:43 DEBUG : only2: md5 = fdc5da2664e57c0f9a5ba6bdefebe9f1 OK 2025/06/19 07:21:44 DEBUG : both3: md5 = 7006bfc9127b69bed5220a0010a4c6c3 OK 2025/06/19 07:21:49 DEBUG : only3: md5 = 913a6e5bc1a605d8868b6c805fdf712a OK 2025/06/19 07:21:54 DEBUG : both4: md5 = 5670dd953a62d8fb5d6884b102535c06 OK 2025/06/19 07:22:00 DEBUG : only4: md5 = 6f5a3a2faba6ac3db26b7a4f961917a5 OK 2025/06/19 07:22:02 DEBUG : both5: md5 = 1153d0590c00c40af6414ba21d5ef439 OK 2025/06/19 07:22:07 DEBUG : only5: md5 = 1116206b93e8a59b6abccd20150594dd OK 2025/06/19 07:22:12 DEBUG : both6: md5 = fb7348b064bf296afad85ce5b70e3ac8 OK 2025/06/19 07:22:13 DEBUG : only6: md5 = c12a5e136366741ce5e7853d012168a9 OK 2025/06/19 07:22:18 DEBUG : both7: md5 = 87c6370bcac69e41a962cd8ecabd31d8 OK 2025/06/19 07:22:19 DEBUG : only7: md5 = 62a097a9d610794b41751539d80e23a7 OK 2025/06/19 07:22:24 DEBUG : both8: md5 = 89c5a3b4ea4a380894a415d632a26f6c OK 2025/06/19 07:22:29 DEBUG : only8: md5 = a7eb74ea5ee07ab92267420ac86ae5f8 OK 2025/06/19 07:22:30 DEBUG : both9: md5 = 404904f7273dc0f5ccf06101699c58f4 OK 2025/06/19 07:22:35 DEBUG : only9: md5 = 21705d6676a843463e9c21fb98c4750c OK 2025/06/19 07:22:35 DEBUG : both10: md5 = aaad9d59732a8b8beeb196dc6704550c OK 2025/06/19 07:22:36 DEBUG : only10: md5 = ee7937915f4d6b65a1e0522cc036e7cb OK 2025/06/19 07:22:37 DEBUG : both11: md5 = 49483e8844b43f776753886e995b5976 OK 2025/06/19 07:22:42 DEBUG : only11: md5 = 368b9f13c0b188fc48f2644600a5ebbf OK 2025/06/19 07:22:48 DEBUG : both12: md5 = e09b7a3c76ab6cdec97194bd232b6627 OK 2025/06/19 07:22:53 DEBUG : only12: md5 = 4266b4f033607015da9bebad8cab82f5 OK 2025/06/19 07:22:53 DEBUG : both13: md5 = 0eadf77519bea41f146247f4440dd1b3 OK 2025/06/19 07:22:58 DEBUG : only13: md5 = 850cd6ed7296aac043ea22012b6c2dbc OK 2025/06/19 07:22:59 DEBUG : both14: md5 = 95206a5f60eb6deb6facca9541bd4b73 OK 2025/06/19 07:22:59 DEBUG : only14: md5 = 8a7499cc786be0db972d6def1d796e96 OK 2025/06/19 07:23:05 DEBUG : both15: md5 = d7b63254fd69cc742759ed41fa2fe133 OK 2025/06/19 07:23:10 DEBUG : only15: md5 = 9aec94b6229237895596eda446598f58 OK 2025/06/19 07:23:15 DEBUG : both16: md5 = 1afc224d0ae3000ff9adbbe4b459d326 OK 2025/06/19 07:23:16 DEBUG : only16: md5 = 062e75b4566ec0e39d9f742b0a933e22 OK 2025/06/19 07:23:16 DEBUG : both17: md5 = 46a2bd4c32449d56c3a9e7534ba75847 OK 2025/06/19 07:23:17 DEBUG : only17: md5 = cf73ccf4b4099284888e829a72a7352a OK 2025/06/19 07:23:22 DEBUG : both18: md5 = 4f803ab20042bc908a8f10dd06fba969 OK 2025/06/19 07:23:22 DEBUG : only18: md5 = d83802522bcbae8845f9883100fd1ac7 OK 2025/06/19 07:23:28 DEBUG : both19: md5 = 7a59b43e4071a6c2c413c0e65ffa6275 OK 2025/06/19 07:23:29 DEBUG : only19: md5 = 3d7111e00648228d3d920fa1b3e2ac96 OK 2025/06/19 07:24:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:24:14 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:14 DEBUG : both10: Unchanged skipping 2025/06/19 07:24:14 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:14 DEBUG : both11: Unchanged skipping 2025/06/19 07:24:14 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:14 DEBUG : both13: Unchanged skipping 2025/06/19 07:24:14 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:14 DEBUG : both12: Unchanged skipping 2025/06/19 07:24:14 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:14 DEBUG : both14: Unchanged skipping 2025/06/19 07:24:14 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:14 DEBUG : both15: Unchanged skipping 2025/06/19 07:24:14 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:14 DEBUG : both17: Unchanged skipping 2025/06/19 07:24:14 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:14 DEBUG : both19: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both0: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both2: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both3: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both16: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both4: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both5: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both18: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both6: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both7: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both8: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both9: Unchanged skipping 2025/06/19 07:24:19 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:24:19 DEBUG : both1: Unchanged skipping 2025/06/19 07:24:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:24:19 DEBUG : Waiting for deletions to finish 2025/06/19 07:24:19 INFO : only14: Deleted 2025/06/19 07:24:24 INFO : only13: Deleted 2025/06/19 07:24:24 INFO : only12: Deleted 2025/06/19 07:24:24 INFO : only9: Deleted 2025/06/19 07:24:29 INFO : only1: Deleted 2025/06/19 07:24:29 INFO : only11: Deleted 2025/06/19 07:24:30 INFO : only0: Deleted 2025/06/19 07:24:30 INFO : only3: Deleted 2025/06/19 07:24:30 INFO : only2: Deleted 2025/06/19 07:24:30 INFO : only6: Deleted 2025/06/19 07:24:30 INFO : only7: Deleted 2025/06/19 07:24:31 INFO : only10: Deleted 2025/06/19 07:24:31 INFO : only16: Deleted 2025/06/19 07:24:31 INFO : only17: Deleted 2025/06/19 07:24:31 INFO : only18: Deleted 2025/06/19 07:24:31 INFO : only19: Deleted 2025/06/19 07:24:35 INFO : only5: Deleted 2025/06/19 07:24:35 INFO : only15: Deleted 2025/06/19 07:24:39 INFO : only4: Deleted 2025/06/19 07:24:41 INFO : only8: Deleted 2025/06/19 07:24:41 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (298.07s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:26:16 DEBUG : both0: md5 = 9eb930da78aa2d994f6ce9af600dd419 OK 2025/06/19 07:26:22 DEBUG : only0: md5 = 790ea4c4767462339247c0fa6a5060f4 OK 2025/06/19 07:26:27 DEBUG : both1: md5 = 8d05b84edee98883a50f43728ee6ff21 OK 2025/06/19 07:26:32 DEBUG : only1: md5 = 388d8a7967228713c540770d07215ae0 OK 2025/06/19 07:26:37 DEBUG : both2: md5 = 2d24ed24bb4243826bfc4072cd64c928 OK 2025/06/19 07:26:37 DEBUG : only2: md5 = ac68021cf5291cdadfee74aa92f2aae9 OK 2025/06/19 07:26:38 DEBUG : both3: md5 = fb091100794689c43b3f6a30713f6a98 OK 2025/06/19 07:26:43 DEBUG : only3: md5 = b777b0fcaaa51d8c2da340727748860a OK 2025/06/19 07:26:48 DEBUG : both4: md5 = 771f521616cb9832fd98a43ca28bc7fc OK 2025/06/19 07:26:53 DEBUG : only4: md5 = 0984eeeb5a20ca7c4d95b47df9ec65c0 OK 2025/06/19 07:26:53 DEBUG : both5: md5 = 302541eb5a95d13ea23d7b0ff61f7761 OK 2025/06/19 07:26:59 DEBUG : only5: md5 = 77c60bec1d39f32191669def95914ef6 OK 2025/06/19 07:27:04 DEBUG : both6: md5 = a9389834ac50f749dfec081e3e977398 OK 2025/06/19 07:27:04 DEBUG : only6: md5 = 7e1c605f3dc3f39936c846d21e4e90d4 OK 2025/06/19 07:27:09 DEBUG : both7: md5 = 11324b4f0928beb7d351771e74c9c424 OK 2025/06/19 07:27:09 DEBUG : only7: md5 = 0a5330260256fd03c8761ac34614984c OK 2025/06/19 07:27:14 DEBUG : both8: md5 = 381075b5f32d51dd96b54097a375f120 OK 2025/06/19 07:27:20 DEBUG : only8: md5 = 53f2cef9fa8ce87a29f1da9d2348a2b9 OK 2025/06/19 07:27:20 DEBUG : both9: md5 = 1e30c9d346cc71d5edcb2917a673a3fd OK 2025/06/19 07:27:25 DEBUG : only9: md5 = 2b82f5f04db6046ed00b420190fd40e6 OK 2025/06/19 07:27:25 DEBUG : both10: md5 = cc7306f84547fb5a4eb33e63805cff68 OK 2025/06/19 07:27:25 DEBUG : only10: md5 = c5d8d676b36de9bd16a04f1c5d7ef9a3 OK 2025/06/19 07:27:25 DEBUG : both11: md5 = b5eb3a92b89c339312c298a12dcd7f97 OK 2025/06/19 07:27:31 DEBUG : only11: md5 = abaaa02f60c6d9de3926b8368e3c0fc9 OK 2025/06/19 07:27:36 DEBUG : both12: md5 = b6cb6894adee9f0707741ef4c8955045 OK 2025/06/19 07:27:41 DEBUG : only12: md5 = 134eed0930a073c4481e79965fe4300b OK 2025/06/19 07:27:41 DEBUG : both13: md5 = 1bfd172b96ee0f61f817c3a2f9dcc23a OK 2025/06/19 07:27:46 DEBUG : only13: md5 = 28af14dcb951867d135eb3ed87a9c15d OK 2025/06/19 07:27:46 DEBUG : both14: md5 = 5a50b6147fd8353b4732fc2b5030c10e OK 2025/06/19 07:27:46 DEBUG : only14: md5 = 218ae069b5aebeb5159533293909d092 OK 2025/06/19 07:27:52 DEBUG : both15: md5 = 39b14deb2c81ed233784e093cc4d0fa2 OK 2025/06/19 07:27:57 DEBUG : only15: md5 = 16c81dd51f4e99b500638c1121b40343 OK 2025/06/19 07:28:02 DEBUG : both16: md5 = dc6fc64a9cb63575f2145b256782b4c1 OK 2025/06/19 07:28:02 DEBUG : only16: md5 = 2b9e66084ebf79abd54cad9e4259f4e8 OK 2025/06/19 07:28:02 DEBUG : both17: md5 = 3be9414ac329a41dd2f2563113b70dea OK 2025/06/19 07:28:03 DEBUG : only17: md5 = f2876fcddf04d102f74cb66e47dc9853 OK 2025/06/19 07:28:08 DEBUG : both18: md5 = 4df6d5a33ff4f6f346f520013a86b21c OK 2025/06/19 07:28:08 DEBUG : only18: md5 = 66e12d6ee820aa72855af82b73503a65 OK 2025/06/19 07:28:13 DEBUG : both19: md5 = dfd04af143fee423d564d0120973a072 OK 2025/06/19 07:28:13 DEBUG : only19: md5 = 7bcadaa9f7f213659668831c033d0965 OK 2025/06/19 07:29:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:29:05 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:05 DEBUG : both0: Unchanged skipping 2025/06/19 07:29:05 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:05 DEBUG : both10: Unchanged skipping 2025/06/19 07:29:05 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:05 DEBUG : both11: Unchanged skipping 2025/06/19 07:29:05 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:05 DEBUG : both12: Unchanged skipping 2025/06/19 07:29:05 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:05 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:05 DEBUG : both13: Unchanged skipping 2025/06/19 07:29:05 DEBUG : both14: Unchanged skipping 2025/06/19 07:29:05 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:05 DEBUG : both15: Unchanged skipping 2025/06/19 07:29:06 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:06 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:06 DEBUG : both18: Unchanged skipping 2025/06/19 07:29:06 DEBUG : both17: Unchanged skipping 2025/06/19 07:29:06 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:06 DEBUG : both19: Unchanged skipping 2025/06/19 07:29:06 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:06 DEBUG : both3: Unchanged skipping 2025/06/19 07:29:06 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:06 DEBUG : both4: Unchanged skipping 2025/06/19 07:29:06 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:06 DEBUG : both5: Unchanged skipping 2025/06/19 07:29:06 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:06 DEBUG : both6: Unchanged skipping 2025/06/19 07:29:11 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:11 DEBUG : both16: Unchanged skipping 2025/06/19 07:29:11 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:11 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:11 DEBUG : both1: Unchanged skipping 2025/06/19 07:29:11 DEBUG : both2: Unchanged skipping 2025/06/19 07:29:11 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/06/19 07:29:11 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:11 DEBUG : both9: Unchanged skipping 2025/06/19 07:29:11 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:11 DEBUG : both7: Unchanged skipping 2025/06/19 07:29:11 DEBUG : only10: md5 = 4a6d004041c712d66d35bb84314e0a26 OK 2025/06/19 07:29:11 INFO : only10: Copied (replaced existing) 2025/06/19 07:29:16 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:29:16 DEBUG : both8: Unchanged skipping 2025/06/19 07:29:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:29:16 DEBUG : only13: md5 = 12ac57357ee1346eb2a2a89c23f5df21 OK 2025/06/19 07:29:16 INFO : only13: Copied (replaced existing) 2025/06/19 07:29:16 DEBUG : only14: md5 = afd269e182c37241678cd749c55ac243 OK 2025/06/19 07:29:16 INFO : only14: Copied (replaced existing) 2025/06/19 07:29:21 DEBUG : only0: md5 = 68ae0829fcf42d2bf0eeb5c98db27cc0 OK 2025/06/19 07:29:21 INFO : only0: Copied (replaced existing) 2025/06/19 07:29:21 DEBUG : only11: md5 = 4b6c8dedadfd7e2ab7633f8bed8a6eca OK 2025/06/19 07:29:21 INFO : only11: Copied (replaced existing) 2025/06/19 07:29:21 DEBUG : only12: md5 = 30226bef3f5d9920bfeda3af070ed8fa OK 2025/06/19 07:29:21 INFO : only12: Copied (replaced existing) 2025/06/19 07:29:21 DEBUG : only16: md5 = 0baea69d5a044f86d1f5a51b56e9ea70 OK 2025/06/19 07:29:21 INFO : only16: Copied (replaced existing) 2025/06/19 07:29:21 DEBUG : only18: md5 = 08d14ad72ee5d35beb175ae5127ec875 OK 2025/06/19 07:29:21 INFO : only18: Copied (replaced existing) 2025/06/19 07:29:21 DEBUG : only17: md5 = 956a89c9ec918d96e88ff4fa6aeacbc6 OK 2025/06/19 07:29:21 INFO : only17: Copied (replaced existing) 2025/06/19 07:29:21 DEBUG : only19: md5 = d341bcb2811fe1861befc8643b0f5a64 OK 2025/06/19 07:29:21 INFO : only19: Copied (replaced existing) 2025/06/19 07:29:21 DEBUG : only15: md5 = 9536e099a2fb6e5f49253df64d2d8ca7 OK 2025/06/19 07:29:21 INFO : only15: Copied (replaced existing) 2025/06/19 07:29:21 DEBUG : only2: md5 = 13e16a90f2a10cafbdb57ca300f1c90f OK 2025/06/19 07:29:21 INFO : only2: Copied (replaced existing) 2025/06/19 07:29:26 DEBUG : only1: md5 = 7d6396fd975384a94443fecf7e7ea6ee OK 2025/06/19 07:29:26 INFO : only1: Copied (replaced existing) 2025/06/19 07:29:27 DEBUG : only3: md5 = b7a4959fb3a6dc9b2c6eb9298523c66d OK 2025/06/19 07:29:27 INFO : only3: Copied (replaced existing) 2025/06/19 07:29:27 DEBUG : only5: md5 = 47e458483b9e0b58f9e2d0648579cf90 OK 2025/06/19 07:29:27 INFO : only5: Copied (replaced existing) 2025/06/19 07:29:27 DEBUG : only6: md5 = bb71959e9fe312af0422604d08d5512b OK 2025/06/19 07:29:27 INFO : only6: Copied (replaced existing) 2025/06/19 07:29:27 DEBUG : only7: md5 = fc51f1262efe7c11e11935e16eaa482f OK 2025/06/19 07:29:27 INFO : only7: Copied (replaced existing) 2025/06/19 07:29:31 DEBUG : only4: md5 = 1fd6d42e289bac9e7eadbb97b09cb29d OK 2025/06/19 07:29:31 INFO : only4: Copied (replaced existing) 2025/06/19 07:29:32 DEBUG : only8: md5 = 6adab225f69b94da6bb8347bd750f394 OK 2025/06/19 07:29:32 INFO : only8: Copied (replaced existing) 2025/06/19 07:29:32 DEBUG : only9: md5 = f6dba7481c093b54dde1000a16e8751d OK 2025/06/19 07:29:32 INFO : only9: Copied (replaced existing) 2025/06/19 07:29:32 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (441.96s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:33:33 DEBUG : empty_dir: Making directory with metadata 2025/06/19 07:33:33 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/19 07:33:33 DEBUG : empty_on_remote: Making directory with metadata 2025/06/19 07:33:33 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/19 07:33:33 INFO : empty_on_remote: Making directory 2025/06/19 07:33:33 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2025/06/19 07:33:34 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/06/19 07:33:34 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/06/19 07:33:34 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/06/19 07:33:34 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) --- PASS: TestSyncReplaceDirModTime (2.08s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:33:35 DEBUG : empty_dir: Making directory with metadata 2025/06/19 07:33:35 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/19 07:33:35 DEBUG : empty_on_remote: Making directory with metadata 2025/06/19 07:33:35 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/19 07:33:35 INFO : empty_on_remote: Making directory 2025/06/19 07:33:35 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2025/06/19 07:33:36 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/06/19 07:33:36 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/06/19 07:33:36 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/06/19 07:33:36 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/06/19 07:33:36 INFO : empty_dir: Set directory modification time (using DirSetModTime) --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (1.75s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:33:37 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/19 07:33:37 INFO : sub dir: Making directory 2025/06/19 07:33:37 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC --- PASS: TestNothingToTransferWithEmptyDirs (12.39s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:33:49 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/19 07:33:49 INFO : sub dir: Making directory 2025/06/19 07:33:49 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC --- PASS: TestNothingToTransferWithoutEmptyDirs (12.05s) === RUN TestTransform === RUN TestTransform/NFC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:34:02 DEBUG : dir1/0000-abcdefg.txt: md5 = 7eb1060e6ea8289f5354230a15902bfd OK 2025/06/19 07:34:02 DEBUG : dir1/0001-bcdefgh.txt: md5 = 907605ccf5d1e73a3652c02288778bd1 OK 2025/06/19 07:34:09 DEBUG : dir1/0002-cdefghi.txt: md5 = 7b4429d1bea0658ddf8c9900b323471d OK 2025/06/19 07:34:14 DEBUG : dir1/0003-defghij.txt: md5 = 50abfe9cd63d5b56ea1ef5a9d72bb04f OK 2025/06/19 07:34:20 DEBUG : dir1/0004-efghijk.txt: md5 = 1e60b8b0483d47423328be9a4c814e4d OK 2025/06/19 07:34:25 DEBUG : dir1/0005-fghijkl.txt: md5 = b3c675b37d2bb47b5f0f0f54c2ecf654 OK 2025/06/19 07:34:26 DEBUG : dir1/0006-ghijklm.txt: md5 = 8df18195829a06f5e6461cdf6227e325 OK 2025/06/19 07:34:31 DEBUG : dir1/0007-1234567.txt: md5 = 0fa90491e28231e1dd4aa06ceff158a1 OK 2025/06/19 07:34:32 DEBUG : dir1/0008-2345678.txt: md5 = 6c71083331e2e30fecf1ebc866d0ec76 OK 2025/06/19 07:34:32 DEBUG : dir1/0009-3456789.txt: md5 = 7380d130fc4d3578b547a5d136f84794 OK 2025/06/19 07:34:38 DEBUG : dir1/0010-456789.txt: md5 = 0810049d189356b572ea9a3dcc210137 OK 2025/06/19 07:34:43 DEBUG : dir1/0011-56789;.txt: md5 = 9443a27d4d9ed2533f10cb05ee62e8c7 OK 2025/06/19 07:34:49 DEBUG : dir1/0012-6789;.txt: md5 = 757b1ed682333205071eb78a749cfb82 OK 2025/06/19 07:34:56 DEBUG : dir1/0013-789;=.txt: md5 = 77cf8c1621fa46022fad14cfbf47a4ee OK 2025/06/19 07:34:57 DEBUG : dir1/0014-89;=.txt: md5 = c43446839f0f3721e6ead8ce13d8a951 OK 2025/06/19 07:34:57 DEBUG : dir1/0015-9;=.txt: md5 = 7dabc22726442beaed277c641495c7f4 OK 2025/06/19 07:34:57 DEBUG : apple: md5 = 10cbc2f787b00f98a43bb2d56b2702fc OK 2025/06/19 07:35:03 DEBUG : banana: md5 = 3b9e77192f96fb33727fd39bc0b79536 OK 2025/06/19 07:35:03 DEBUG : appleappleapplebanana: md5 = ed1037a748227634e7ef9682095276c7 OK 2025/06/19 07:35:08 DEBUG : splitbananasplit: md5 = 5394569ee398f22546f55db7661d310b OK 2025/06/19 07:35:08 DEBUG : Waiting for deletions to finish 2025/06/19 07:35:08 DEBUG : apple: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : banana: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/06/19 07:35:08 DEBUG : splitbananasplit: Excluded (Path Filter) 2025/06/19 07:35:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:35:20 DEBUG : apple: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : apple: Unchanged skipping 2025/06/19 07:35:20 DEBUG : appleappleapplebanana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : appleappleapplebanana: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0000-abcdefg.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : banana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0000-abcdefg.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : banana: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0001-bcdefgh.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0001-bcdefgh.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0002-cdefghi.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0002-cdefghi.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0003-defghij.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0003-defghij.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0005-fghijkl.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0005-fghijkl.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0004-efghijk.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0004-efghijk.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0006-ghijklm.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0006-ghijklm.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0008-2345678.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0008-2345678.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0007-1234567.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0007-1234567.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0009-3456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0009-3456789.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0011-56789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0011-56789;.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0010-456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0010-456789.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0013-789;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0013-789;=.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0015-9;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0015-9;=.txt: Unchanged skipping 2025/06/19 07:35:20 DEBUG : dir1/0014-89;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:20 DEBUG : dir1/0014-89;=.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : splitbananasplit: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : splitbananasplit: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0012-6789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0012-6789;.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:35:25 DEBUG : Waiting for deletions to finish 2025/06/19 07:35:25 INFO : There was nothing to transfer 2025/06/19 07:35:25 DEBUG : Waiting for deletions to finish 2025/06/19 07:35:25 DEBUG : apple: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : banana: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : splitbananasplit: Excluded (Path Filter) 2025/06/19 07:35:25 DEBUG : apple: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : apple: Unchanged skipping 2025/06/19 07:35:25 DEBUG : appleappleapplebanana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : appleappleapplebanana: Unchanged skipping 2025/06/19 07:35:25 DEBUG : banana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : banana: Unchanged skipping 2025/06/19 07:35:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for checks to finish 2025/06/19 07:35:25 DEBUG : dir1/0001-bcdefgh.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0001-bcdefgh.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0002-cdefghi.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0002-cdefghi.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0000-abcdefg.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0000-abcdefg.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0006-ghijklm.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0006-ghijklm.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0004-efghijk.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0004-efghijk.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0003-defghij.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0003-defghij.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0007-1234567.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0007-1234567.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0009-3456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0009-3456789.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0008-2345678.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0008-2345678.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0010-456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0010-456789.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0015-9;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0015-9;=.txt: Unchanged skipping 2025/06/19 07:35:25 DEBUG : dir1/0014-89;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:25 DEBUG : dir1/0014-89;=.txt: Unchanged skipping 2025/06/19 07:35:30 DEBUG : splitbananasplit: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:30 DEBUG : splitbananasplit: Unchanged skipping 2025/06/19 07:35:30 DEBUG : dir1/0005-fghijkl.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:30 DEBUG : dir1/0005-fghijkl.txt: Unchanged skipping 2025/06/19 07:35:30 DEBUG : dir1/0012-6789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:30 DEBUG : dir1/0012-6789;.txt: Unchanged skipping 2025/06/19 07:35:30 DEBUG : dir1/0011-56789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:30 DEBUG : dir1/0011-56789;.txt: Unchanged skipping 2025/06/19 07:35:30 DEBUG : dir1/0013-789;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 07:35:30 DEBUG : dir1/0013-789;=.txt: Unchanged skipping 2025/06/19 07:35:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi': Waiting for transfers to finish 2025/06/19 07:35:30 DEBUG : Waiting for deletions to finish 2025/06/19 07:35:30 INFO : There was nothing to transfer 2025/06/19 07:35:30 DEBUG : Waiting for deletions to finish 2025/06/19 07:35:30 DEBUG : apple: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : banana: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/06/19 07:35:30 DEBUG : splitbananasplit: Excluded (Path Filter) === RUN TestTransform/NFD run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-majesad5gepi'", Local "Local file system at /tmp/rclone3234654002", Modify Window "1ns" 2025/06/19 07:36:44 DEBUG : dir1/0000-abcdefg.txt: md5 = 904393a929a7b99564e67bd082c5613e OK 2025/06/19 07:36:44 DEBUG : dir1/0001-bcdefgh.txt: md5 = 5ada2e71c8921c769744b37c1e4b3380 OK 2025/06/19 07:36:49 DEBUG : dir1/0002-cdefghi.txt: md5 = e87e2ce8a63523c58427e7de89d98108 OK 2025/06/19 07:36:55 DEBUG : dir1/0003-defghij.txt: md5 = 6ff7a8f9ef0ebb8f1ae3665838e0014b OK 2025/06/19 07:37:00 DEBUG : dir1/0004-efghijk.txt: md5 = ed0585fd00237430cc26b542b02dd261 OK 2025/06/19 07:37:05 DEBUG : dir1/0005-fghijkl.txt: md5 = 30308556d3ae1282875d51644c0ccf76 OK 2025/06/19 07:37:05 DEBUG : dir1/0006-ghijklm.txt: md5 = ddab49f937c968baff0ea943cbf1a7b4 OK 2025/06/19 07:37:10 DEBUG : dir1/0007-1234567.txt: md5 = c657174da99442ab066e99ddcf073297 OK 2025/06/19 07:37:10 DEBUG : dir1/0008-2345678.txt: md5 = fbe1878eb3c9edae22bd2729f7260cbc OK 2025/06/19 07:37:11 DEBUG : dir1/0009-3456789.txt: md5 = c0b777e05619b1a4479b2d7a7d513617 OK 2025/06/19 07:37:16 DEBUG : dir1/0010-456789.txt: md5 = ce1c7acd8d0cd5658c56d655ef51a23f OK 2025/06/19 07:37:21 DEBUG : dir1/0011-56789;.txt: md5 = 29e8093f14dd2d5575ff6938580d4cbf OK panic: test timed out after 1h0m0s running tests: TestTransform (3m25s) TestTransform/NFD (42s) goroutine 14702 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:2484 +0x394 created by time.goFunc /usr/local/go/src/time/sleep.go:215 +0x2d goroutine 1 [chan receive, 3 minutes]: testing.(*T).Run(0xc0004f56c0, {0x26944db?, 0xc0006a3ad8?}, 0x27c0998) /usr/local/go/src/testing/testing.go:1859 +0x431 testing.runTests.func1(0xc0004f56c0) /usr/local/go/src/testing/testing.go:2279 +0x37 testing.tRunner(0xc0004f56c0, 0xc0006a3c18) /usr/local/go/src/testing/testing.go:1792 +0xf4 testing.runTests(0xc000600f30, {0x3e7c5e0, 0x6b, 0x6b}, {0xedfe5a726?, 0x3e925a0?, 0x3e925a0?}) /usr/local/go/src/testing/testing.go:2277 +0x4b4 testing.(*M).Run(0xc000488e60) /usr/local/go/src/testing/testing.go:2142 +0x64a github.com/rclone/rclone/fstest.TestMain(0xc000488e60) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:69 +0xa5 github.com/rclone/rclone/fs/sync.TestMain(...) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:45 main.main() _testmain.go:259 +0xa9 goroutine 36 [syscall, 60 minutes]: os/signal.signal_recv() /usr/local/go/src/runtime/sigqueue.go:152 +0x29 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:23 +0x13 created by os/signal.Notify.func1.1 in goroutine 1 /usr/local/go/src/os/signal/signal.go:152 +0x1f goroutine 37 [chan receive, 60 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 13973 [chan receive, 2 minutes]: testing.(*T).Run(0xc000510540, {0x2678b35?, 0x41bb05?}, 0xc0001c5e50) /usr/local/go/src/testing/testing.go:1859 +0x431 github.com/rclone/rclone/fs/sync.TestTransform(0xc000510540) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:95 +0x62a testing.tRunner(0xc000510540, 0x27c0998) /usr/local/go/src/testing/testing.go:1792 +0xf4 created by testing.(*T).Run in goroutine 1 /usr/local/go/src/testing/testing.go:1851 +0x413 goroutine 14701 [runnable]: net/http.(*persistConn).roundTrip(0xc00086e360, 0xc000ac47d0) /usr/local/go/src/net/http/transport.go:2826 +0x785 net/http.(*Transport).roundTrip(0xc000194000, 0xc000afe280) /usr/local/go/src/net/http/transport.go:696 +0xb9a net/http.(*Transport).RoundTrip(...) /usr/local/go/src/net/http/roundtrip.go:30 github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc000416150, 0xc000afe280) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345 net/http.send(0xc000afe280, {0x2accd20, 0xc000416150}, {0x1?, 0x0?, 0x0?}) /usr/local/go/src/net/http/client.go:259 +0x5e2 net/http.(*Client).send(0xc001a5a240, 0xc000afe280, {0x0?, 0x0?, 0x0?}) /usr/local/go/src/net/http/client.go:180 +0x91 net/http.(*Client).do(0xc001a5a240, 0xc000afe280) /usr/local/go/src/net/http/client.go:728 +0x989 net/http.(*Client).Do(...) /usr/local/go/src/net/http/client.go:587 github.com/ncw/swift/v2.(*Connection).doTimeoutRequest.func1() /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:421 +0x2b created by github.com/ncw/swift/v2.(*Connection).doTimeoutRequest in goroutine 14691 /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8 goroutine 1965 [chan receive, 53 minutes]: github.com/rclone/rclone/lib/atexit.Register.func1.1() /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:45 +0x29 created by github.com/rclone/rclone/lib/atexit.Register.func1 in goroutine 2057 /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68 goroutine 14691 [select, 2 minutes]: github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc00047e3c0, 0xc0003915e0, 0xc000afe280) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115 github.com/ncw/swift/v2.(*Connection).Call(0xc00047e3c0, {0x2af3868, 0x3eb5b60}, {0xc0019dd720, 0x4f}, {{0xc00195e840, 0x5}, {0xc00195e846, 0x30}, {0x2678d24, ...}, ...}) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6 github.com/ncw/swift/v2.(*Connection).storage(0xc00047e3c0, {0x2af3868, 0x3eb5b60}, {{0xc00195e840, 0x5}, {0xc00195e846, 0x30}, {0x2678d24, 0x3}, 0x0, ...}) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:847 +0x151 github.com/ncw/swift/v2.(*Connection).objectPut(0xc00047e3c0, {0x2af3868, 0x3eb5b60}, {0xc00195e840, 0x5}, {0xc00195e846, 0x30}, {0x2acb4a0, 0xc001f25d80}, 0x1, ...) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:1569 +0x1f5 github.com/ncw/swift/v2.(*Connection).ObjectPut(...) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:1615 github.com/rclone/rclone/backend/swift.(*Object).Update.func1() /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1559 +0xb0 github.com/rclone/rclone/fs.pacerInvoker(0x1, 0x1, 0x0?) /home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32 github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc001a98000, 0xc00012d700, 0x1) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:197 +0x7c github.com/rclone/rclone/lib/pacer.(*Pacer).CallNoRetry(...) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:225 github.com/rclone/rclone/backend/swift.(*Object).Update(0xc000a096e0, {0x2af3868, 0x3eb5b60}, {0x2acb4a0, 0xc001f25d80}, {0x2afeae0, 0xc00216f4d0}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1558 +0x7b8 github.com/rclone/rclone/backend/swift.(*Fs).Put(0xc001a9a000, {0x2af3868, 0x3eb5b60}, {0x2acb4a0, 0xc001f25d80}, {0x2afeae0, 0xc00216f4d0}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:937 +0x139 github.com/rclone/rclone/backend/crypt.(*Fs).put(0xc00056cd00, {0x2af3868, 0x3eb5b60}, {0x2acb2a0, 0xc00216f440}, {0x2afe950, 0xc000391420}, {0x0, 0x0, 0x0}, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:536 +0x3c3 github.com/rclone/rclone/backend/crypt.(*Fs).Put(0x461f3c?, {0x2af3868?, 0x3eb5b60?}, {0x2acb2a0?, 0xc00216f440?}, {0x2afe950?, 0xc000391420?}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:571 +0x91 github.com/rclone/rclone/fstest.(*Run).WriteObjectTo(0xc00042d7a0, {0x2af3868, 0x3eb5b60}, {0x2b07fe0, 0xc00056cd00}, {0xc00072d770, 0x13}, {0xc00072d770, 0x13}, {0x1dcd64ff, ...}, ...) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:275 +0x3f2 github.com/rclone/rclone/fstest.(*Run).WriteObject(...) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:292 github.com/rclone/rclone/fs/sync.makeTestFiles(0xc00042d7a0?, 0xc00042d7a0, {0x2679a9c, 0x4}) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:150 +0x425 github.com/rclone/rclone/fs/sync.TestTransform.func1(0xc0009468c0) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:102 +0xd3 testing.tRunner(0xc0009468c0, 0xc0001c5e50) /usr/local/go/src/testing/testing.go:1792 +0xf4 created by testing.(*T).Run in goroutine 13973 /usr/local/go/src/testing/testing.go:1851 +0x413 goroutine 13820 [select, 2 minutes]: github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0002d7860, {0x2af3948, 0xc00064ea50}) /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145 created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 13682 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x117 goroutine 14471 [select, 2 minutes]: net/http.(*persistConn).writeLoop(0xc00086e360) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14407 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 14470 [runnable]: syscall.Syscall(0x0, 0x12, 0xc000558c80, 0x1980) /usr/local/go/src/syscall/syscall_linux.go:73 +0x25 syscall.read(0xc001d86b00?, {0xc000558c80?, 0xc000558c00?, 0xc0009077d0?}) /usr/local/go/src/syscall/zsyscall_linux_amd64.go:736 +0x38 syscall.Read(...) /usr/local/go/src/syscall/syscall_unix.go:183 internal/poll.ignoringEINTRIO(...) /usr/local/go/src/internal/poll/fd_unix.go:745 internal/poll.(*FD).Read(0xc001d86b00, {0xc000558c80, 0x1980, 0x1980}) /usr/local/go/src/internal/poll/fd_unix.go:161 +0x2ae net.(*netFD).Read(0xc001d86b00, {0xc000558c80?, 0x30?, 0x0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc000512128, {0xc000558c80?, 0x73f6817cd228?, 0x6?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc00205e828, {0xc000558c80?, 0x73f6817cd228?, 0x73f6d00b2f30?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc001796000, {0xc000558c80?, 0x0?, 0x9079d0?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0006e69b8, {0x2ace280, 0xc001796000}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc0006e6708, {0x73f6881ada18, 0xc00205e828}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc0006e6708, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc0006e6708, {0xc000a48000, 0x1000, 0xc000121170?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc00086e360, {0xc000a48000?, 0x7f4ac5?, 0x2acb1a0?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc000a08d80) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc000a08d80, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc00086e360) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14407 /usr/local/go/src/net/http/transport.go:1944 +0x174f "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished ERROR in 1h0m11.351205707s (try 4/5): exit status 2: Failed []