"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 2/5) 2025/07/05 05:15:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa" 2025/07/05 05:15:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/05 05:15:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa.bin" 2025/07/05 05:15:09 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa.bin: Auto set use_segments_container to true 2025/07/05 05:15:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa" 2025/07/05 05:15:15 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa: Auto set use_segments_container to true 2025/07/05 05:15:20 DEBUG : Creating backend with remote "/tmp/rclone3868557063" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.02s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:15:20 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:15:20 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/07/05 05:15:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:15:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish --- PASS: TestCopyWithDryRun (0.54s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:15:21 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/07/05 05:15:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:15:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:15:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:15:26 DEBUG : sub dir/hello world: md5 = c4cdf6c57c6ef844e451ca99fd5ae33e OK 2025/07/05 05:15:26 INFO : sub dir/hello world: Copied (new) 2025/07/05 05:15:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (15.94s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:98: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.10s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:98: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.10s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:15:37 DEBUG : Creating backend with remote "/non-existing" 2025/07/05 05:15:37 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/07/05 05:15:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:15:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.29s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:15:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:15:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:15:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:15:52 DEBUG : sub dir/hello world: md5 = 77530631bee4f699aeae17d4e37f55f1 OK 2025/07/05 05:15:52 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (21.17s) === RUN TestCopyNoTraverseDeadlock run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:222: Only runs on local --- SKIP: TestCopyNoTraverseDeadlock (0.10s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:15:58 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Running all checks before starting transfers 2025/07/05 05:15:58 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:15:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:15:58 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Checks finished, now starting transfers 2025/07/05 05:15:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:16:04 DEBUG : sub dir/hello world: md5 = ee522cfdff6ba4aa11585ed76f5782e0 OK 2025/07/05 05:16:04 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (16.08s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:16:14 ERROR : Ignoring --no-traverse with sync 2025/07/05 05:16:14 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:16:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:16:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:16:20 DEBUG : sub dir/hello world: md5 = 6efd54e4bcd39da30a0eb819b1c30afd OK 2025/07/05 05:16:20 INFO : sub dir/hello world: Copied (new) 2025/07/05 05:16:20 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (11.03s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:16:26 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/07/05 05:16:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:16:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:16:31 DEBUG : hello world2: md5 = 12001c7cf2571e045ae8d7cc9faeb0b7 OK 2025/07/05 05:16:31 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (11.03s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:16:36 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:16:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:16:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:16:37 DEBUG : potato2: md5 = 8a56239fac7f1ba3e762db6319e09e2b OK 2025/07/05 05:16:37 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (0.98s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:16:42 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:16:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:16:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:16:43 DEBUG : potato2: md5 = a32aa99e7734b5949be16bc18d30a0ca OK 2025/07/05 05:16:43 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (6.02s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:16:43 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/07/05 05:16:43 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 05:16:43 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/07/05 05:16:43 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/07/05 05:16:44 INFO : sub dir2: Making directory 2025/07/05 05:16:44 INFO : sub dir: Making directory 2025/07/05 05:16:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:16:44 INFO : sub dir2/sub sub dir2: Making directory 2025/07/05 05:16:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:16:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:16:49 DEBUG : sub dir/hello world: md5 = 4f6b73c92f0cde87bece7c188a2d88e2 OK 2025/07/05 05:16:49 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/07/05 05:16:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (15.93s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:16:59 INFO : sub dir2: Making directory 2025/07/05 05:16:59 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/07/05 05:16:59 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 05:16:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:16:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:16:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:17:05 DEBUG : sub dir/hello world: md5 = 05e3f8d771b0a6d5fe7ffa527aab273b OK 2025/07/05 05:17:05 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (10.82s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:17:10 DEBUG : sub dir2: Making directory with metadata 2025/07/05 05:17:10 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 05:17:10 INFO : sub dir2: Making directory 2025/07/05 05:17:10 INFO : sub dir: Making directory 2025/07/05 05:17:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:17:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:17:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:17:15 DEBUG : sub dir/hello world: md5 = 73d012ac76f88c9f02fcae3c9277b866 OK 2025/07/05 05:17:15 INFO : sub dir/hello world: Copied (new) 2025/07/05 05:17:15 INFO : sub dir/hello world: Deleted fstest.go:247: Filtering empty directory "sub dir2" 2025/07/05 05:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/07/05 05:17:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (11.03s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:438: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.20s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:17:21 INFO : sub dir2: Making directory 2025/07/05 05:17:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:17:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:17:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:17:27 DEBUG : sub dir/hello world: md5 = 47711448eacbaf521987e3f1c121a4e4 OK 2025/07/05 05:17:27 INFO : sub dir/hello world: Copied (new) 2025/07/05 05:17:27 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (15.88s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:17:37 DEBUG : sub dir2: Making directory with metadata 2025/07/05 05:17:37 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 05:17:37 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/07/05 05:17:37 INFO : sub dir2: Making directory 2025/07/05 05:17:37 INFO : sub dir: Making directory 2025/07/05 05:17:37 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:17:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:17:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:17:46 DEBUG : sub dir/hello world: md5 = 175d709b2b5d9766f056071c1f5f13ec OK 2025/07/05 05:17:46 INFO : sub dir/hello world: Copied (new) 2025/07/05 05:17:46 DEBUG : Waiting for deletions to finish fstest.go:247: Filtering empty directory "sub dir2" 2025/07/05 05:17:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (18.87s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:537: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.12s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:17:56 INFO : sub dir2: Making directory 2025/07/05 05:17:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:17:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:17:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:18:02 DEBUG : sub dir/hello world: md5 = ba9f0882e518384c9e39614a3d387903 OK 2025/07/05 05:18:02 INFO : sub dir/hello world: Copied (new) 2025/07/05 05:18:02 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (11.05s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:18:13 DEBUG : sub dir/hello world: md5 = 5595329cf1f1f5d7215377e408a9865d OK 2025/07/05 05:18:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-faveref9tegi" 2025/07/05 05:18:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-faveref9tegi.bin" 2025/07/05 05:18:13 DEBUG : Swift container crypt path rclone-test-faveref9tegi.bin: Auto set use_segments_container to true 2025/07/05 05:18:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-faveref9tegi" 2025/07/05 05:18:19 DEBUG : Swift container crypt path rclone-test-faveref9tegi: Auto set use_segments_container to true sync_test.go:620: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa' -> Encrypted drive 'TestCryptSwift:rclone-test-faveref9tegi' 2025/07/05 05:18:25 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:18:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-faveref9tegi': Waiting for checks to finish 2025/07/05 05:18:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-faveref9tegi': Waiting for transfers to finish 2025/07/05 05:18:35 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 05:18:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-faveref9tegi': Purge remote 2025/07/05 05:18:35 DEBUG : Waiting for deletions to finish 2025/07/05 05:18:46 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (43.74s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:18:56 DEBUG : sub dir/hello world: md5 = 239cce58dbc2277b2e4532a67525eab9 OK 2025/07/05 05:18:57 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/05 05:18:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:18:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:19:02 DEBUG : sub dir/hello world: md5 = 028496ae6d323d452d92c9775e7e4fa7 OK 2025/07/05 05:19:02 INFO : sub dir/hello world: Copied (replaced existing) --- PASS: TestCopyOverSelf (16.42s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:19:13 DEBUG : sub dir/hello world: md5 = 90e15fba77b31d7350fefc4d1da33bc4 OK 2025/07/05 05:19:18 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-luqetoc5zapu" 2025/07/05 05:19:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-luqetoc5zapu.bin" 2025/07/05 05:19:18 DEBUG : Swift container crypt path rclone-test-luqetoc5zapu.bin: Auto set use_segments_container to true 2025/07/05 05:19:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-luqetoc5zapu" 2025/07/05 05:19:24 DEBUG : Swift container crypt path rclone-test-luqetoc5zapu: Auto set use_segments_container to true sync_test.go:656: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa' -> Encrypted drive 'TestCryptSwift:rclone-test-luqetoc5zapu' 2025/07/05 05:19:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:19:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luqetoc5zapu': Waiting for checks to finish 2025/07/05 05:19:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luqetoc5zapu': Waiting for transfers to finish 2025/07/05 05:19:40 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 05:19:45 DEBUG : sub dir/hello world: md5 = 7489a428009625785880abc8f991127f OK 2025/07/05 05:19:51 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/05 05:19:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luqetoc5zapu': Waiting for checks to finish 2025/07/05 05:19:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luqetoc5zapu': Waiting for transfers to finish 2025/07/05 05:20:01 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 05:20:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-luqetoc5zapu': Purge remote 2025/07/05 05:20:01 DEBUG : Waiting for deletions to finish 2025/07/05 05:20:01 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (59.57s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:20:12 DEBUG : sub dir/hello world: md5 = 28a3c0c1c36a847a4f29152d2d1e832e OK 2025/07/05 05:20:13 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/05 05:20:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:20:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:20:18 DEBUG : sub dir/hello world: md5 = c10568c20fbfa7de28283336a319436f OK 2025/07/05 05:20:18 INFO : sub dir/hello world: Copied (replaced existing) 2025/07/05 05:20:18 INFO : sub dir/hello world: Deleted --- PASS: TestMoveOverSelf (27.08s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:20:39 DEBUG : sub dir/hello world: md5 = f560801941f4ee832cfceae4d054a5de OK 2025/07/05 05:20:40 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tabiwad1qaga" 2025/07/05 05:20:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tabiwad1qaga.bin" 2025/07/05 05:20:40 DEBUG : Swift container crypt path rclone-test-tabiwad1qaga.bin: Auto set use_segments_container to true 2025/07/05 05:20:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tabiwad1qaga" 2025/07/05 05:20:46 DEBUG : Swift container crypt path rclone-test-tabiwad1qaga: Auto set use_segments_container to true sync_test.go:701: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa' -> Encrypted drive 'TestCryptSwift:rclone-test-tabiwad1qaga' 2025/07/05 05:20:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:20:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tabiwad1qaga': Waiting for checks to finish 2025/07/05 05:20:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tabiwad1qaga': Waiting for transfers to finish 2025/07/05 05:21:13 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 05:21:23 DEBUG : sub dir/hello world: md5 = 542818f2551cf8e90f2e5c01f16a100c OK 2025/07/05 05:21:24 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/05 05:21:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tabiwad1qaga': Waiting for checks to finish 2025/07/05 05:21:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tabiwad1qaga': Waiting for transfers to finish 2025/07/05 05:21:39 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 05:21:45 INFO : sub dir/hello world: Deleted 2025/07/05 05:21:50 DEBUG : sub dir/hello world: md5 = 5bb9af05833b7e5750c354ad5e7b51b2 OK 2025/07/05 05:21:50 DEBUG : testing file moves 2025/07/05 05:21:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tabiwad1qaga': Waiting for checks to finish 2025/07/05 05:21:51 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/07/05 05:21:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tabiwad1qaga': Waiting for transfers to finish 2025/07/05 05:22:06 INFO : sub dir/hello world: Copied (server-side copy) 2025/07/05 05:22:11 INFO : sub dir/hello world: Deleted 2025/07/05 05:22:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tabiwad1qaga': Purge remote 2025/07/05 05:22:12 DEBUG : Waiting for deletions to finish 2025/07/05 05:22:22 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (107.89s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:22:27 DEBUG : sub dir/hello world: md5 = d9049fcfc85cb18861fe2e7acfda1c4e OK 2025/07/05 05:22:27 ERROR : error listing: directory not found 2025/07/05 05:22:27 INFO : Local file system at /tmp/rclone3868557063: Making directory 2025/07/05 05:22:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:22:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish --- PASS: TestCopyAfterDelete (16.19s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:22:43 DEBUG : sub dir/hello world: md5 = 33dadbbcc86d2b98bf41b697dd34dc45 OK 2025/07/05 05:22:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:22:49 DEBUG : Local file system at /tmp/rclone3868557063: Waiting for checks to finish 2025/07/05 05:22:49 DEBUG : Local file system at /tmp/rclone3868557063: Waiting for transfers to finish 2025/07/05 05:22:54 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/07/05 05:22:54 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (20.96s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:22:59 DEBUG : check sum: Need to transfer - File not found at Destination 2025/07/05 05:22:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:22:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:04 DEBUG : check sum: md5 = 3c59b1a058beaa62eb03a1e7656b05d5 OK 2025/07/05 05:23:04 INFO : check sum: Copied (new) 2025/07/05 05:23:04 DEBUG : Waiting for deletions to finish 2025/07/05 05:23:05 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/07/05 05:23:05 DEBUG : check sum: Size of src and dst objects identical 2025/07/05 05:23:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:23:05 DEBUG : check sum: Unchanged skipping 2025/07/05 05:23:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:05 DEBUG : Waiting for deletions to finish 2025/07/05 05:23:05 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (11.06s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:23:10 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/07/05 05:23:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:23:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:11 DEBUG : sizeonly: md5 = b69605f23481ec8d001ca2f9a205b717 OK 2025/07/05 05:23:11 INFO : sizeonly: Copied (new) 2025/07/05 05:23:11 DEBUG : Waiting for deletions to finish 2025/07/05 05:23:11 DEBUG : sizeonly: Sizes identical 2025/07/05 05:23:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:23:11 DEBUG : sizeonly: Unchanged skipping 2025/07/05 05:23:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:11 DEBUG : Waiting for deletions to finish 2025/07/05 05:23:11 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (1.44s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:23:12 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/07/05 05:23:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:23:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:13 DEBUG : ignore-size: md5 = 5137f5f96e52a19e7cb2f7af74b9094c OK 2025/07/05 05:23:13 INFO : ignore-size: Copied (new) 2025/07/05 05:23:13 DEBUG : Waiting for deletions to finish 2025/07/05 05:23:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:23:13 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:23:13 DEBUG : ignore-size: Unchanged skipping 2025/07/05 05:23:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:13 DEBUG : Waiting for deletions to finish 2025/07/05 05:23:13 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (1.96s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:23:19 DEBUG : existing: md5 = 6d68c6b006bc0f2249a53082d71609b2 OK 2025/07/05 05:23:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:23:29 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:23:29 DEBUG : existing: Unchanged skipping 2025/07/05 05:23:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:29 DEBUG : Waiting for deletions to finish 2025/07/05 05:23:29 INFO : There was nothing to transfer 2025/07/05 05:23:29 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/07/05 05:23:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:23:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:35 DEBUG : existing: md5 = ffe8c9c7c7948e6dd0457bc4c610aabc OK 2025/07/05 05:23:35 INFO : existing: Copied (replaced existing) 2025/07/05 05:23:35 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (26.42s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:23:40 DEBUG : existing: Need to transfer - File not found at Destination 2025/07/05 05:23:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:23:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:45 DEBUG : existing: md5 = ec13ade668db5680149a6a818c4e7293 OK 2025/07/05 05:23:45 INFO : existing: Copied (new) 2025/07/05 05:23:45 DEBUG : Waiting for deletions to finish 2025/07/05 05:23:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:23:51 DEBUG : existing: Destination exists, skipping 2025/07/05 05:23:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:23:51 DEBUG : Waiting for deletions to finish 2025/07/05 05:23:51 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (17.07s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:24:02 DEBUG : b/potato: md5 = 8ebe2617bbc8776906a7a2ef9f685a00 OK 2025/07/05 05:24:03 DEBUG : c/non empty space: md5 = 0b37f0868ae37be100cd68e4d131f007 OK 2025/07/05 05:24:03 INFO : d: Making directory fstest.go:247: Filtering empty directory "d" 2025/07/05 05:24:09 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/07/05 05:24:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:24:09 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:24:09 DEBUG : c/non empty space: Unchanged skipping 2025/07/05 05:24:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:24:14 DEBUG : a/potato2: md5 = ba0f31e448623850725a7e29c2e80a3a OK 2025/07/05 05:24:14 INFO : a/potato2: Copied (new) 2025/07/05 05:24:14 DEBUG : Waiting for deletions to finish 2025/07/05 05:24:19 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (33.12s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:24:36 DEBUG : empty space: md5 = 272df3f47caa2fbf07682fb615cf374a OK 2025/07/05 05:24:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:24:41 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/07/05 05:24:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:24:41 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/07/05 05:24:41 DEBUG : Waiting for deletions to finish 2025/07/05 05:24:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:24:41 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/07/05 05:24:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:24:46 DEBUG : empty space: md5 = d93f23fd1753a9045fabdc67de16faa3 OK 2025/07/05 05:24:46 INFO : empty space: Copied (replaced existing) 2025/07/05 05:24:46 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingModtimeOnly (31.64s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:1046: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.10s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:25:03 DEBUG : foo: md5 = 7511d9616b7b330af803a3e911c243c6 OK 2025/07/05 05:25:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:25:03 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/07/05 05:25:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:25:03 DEBUG : foo: md5 = bae0dffb7fc57d4e5e992431bee09c33 OK 2025/07/05 05:25:03 INFO : foo: Copied (replaced existing) 2025/07/05 05:25:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (2.47s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:25:10 DEBUG : empty space: md5 = 69c34347101726811a13124641a89a6b OK 2025/07/05 05:25:10 DEBUG : potato: Need to transfer - File not found at Destination 2025/07/05 05:25:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:25:10 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:25:10 DEBUG : empty space: Unchanged skipping 2025/07/05 05:25:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:25:15 DEBUG : potato: md5 = fac8ddcbef1d625ee58feb1e280c7854 OK 2025/07/05 05:25:15 INFO : potato: Copied (new) 2025/07/05 05:25:15 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (31.57s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:25:41 DEBUG : potato: md5 = 0d7a71ebb6dd27b832be6ec82e79114b OK 2025/07/05 05:25:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:25:46 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/07/05 05:25:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:25:52 DEBUG : potato: md5 = de33b833eac2f7442dcabe63c2a77d1a OK 2025/07/05 05:25:52 INFO : potato: Copied (replaced existing) 2025/07/05 05:25:52 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (21.25s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:26:03 DEBUG : potato: md5 = 80bf17393e5b74b3a0a7b3da96a060cf OK 2025/07/05 05:26:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:26:08 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/07/05 05:26:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:26:13 DEBUG : potato: md5 = 52897a3d2c8f84019cc7c9466f2885bc OK 2025/07/05 05:26:13 INFO : potato: Copied (replaced existing) 2025/07/05 05:26:13 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (26.72s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:26:29 DEBUG : potato: md5 = bf10dfb91490714464865e7161197168 OK 2025/07/05 05:26:34 DEBUG : empty space: md5 = 6e3a85dc6c420ce81bbf1a68a587fa02 OK 2025/07/05 05:26:34 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:26:34 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/07/05 05:26:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:26:40 DEBUG : empty space: Unchanged skipping 2025/07/05 05:26:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:26:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:26:40 DEBUG : Waiting for deletions to finish 2025/07/05 05:26:40 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (36.37s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:27:05 DEBUG : potato: md5 = d0e0510ef91afaf94857682c2ef03e45 OK 2025/07/05 05:27:11 DEBUG : empty space: md5 = 8235383af62d08f71d320066ead81964 OK 2025/07/05 05:27:11 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:27:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:27:11 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:27:11 DEBUG : empty space: Unchanged skipping 2025/07/05 05:27:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:27:11 DEBUG : potato2: md5 = 545523fa3cba2454b2ae098d7c5fd893 OK 2025/07/05 05:27:11 INFO : potato2: Copied (new) 2025/07/05 05:27:11 DEBUG : Waiting for deletions to finish 2025/07/05 05:27:16 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (26.90s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:27:32 DEBUG : b/potato: md5 = 0fa4f846a74f3adb3690b03945c71b9b OK 2025/07/05 05:27:33 DEBUG : c/non empty space: md5 = 48528c34eabb1e1eae07c9b2b8beb14a OK 2025/07/05 05:27:33 INFO : d: Making directory 2025/07/05 05:27:33 INFO : d/e: Making directory fstest.go:247: Filtering empty directory "d" fstest.go:247: Filtering empty directory "d/e" 2025/07/05 05:27:33 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/07/05 05:27:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:27:33 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:27:33 DEBUG : c/non empty space: Unchanged skipping 2025/07/05 05:27:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:27:39 DEBUG : a/potato2: md5 = 85b797c88561b3daeb3f92561bc9aa16 OK 2025/07/05 05:27:39 INFO : a/potato2: Copied (new) 2025/07/05 05:27:39 DEBUG : Waiting for deletions to finish 2025/07/05 05:27:44 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (27.47s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:28:00 DEBUG : b/potato: md5 = 5723802528a30194d89a935962197c41 OK 2025/07/05 05:28:00 DEBUG : c/non empty space: md5 = 76f73964c76c575398312bd58ac53aee OK 2025/07/05 05:28:00 INFO : d: Making directory fstest.go:247: Filtering empty directory "d" 2025/07/05 05:28:01 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/07/05 05:28:01 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:28:01 DEBUG : c/non empty space: Unchanged skipping 2025/07/05 05:28:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:28:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:28:06 DEBUG : a/potato2: md5 = b7ae3d4e9bf93cef14d64a426bd7f960 OK 2025/07/05 05:28:06 INFO : a/potato2: Copied (new) 2025/07/05 05:28:06 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': not deleting files as there were IO errors 2025/07/05 05:28:11 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': not deleting directories as there were IO errors fstest.go:247: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (27.77s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:28:28 DEBUG : potato: md5 = 33485f520953596ad16c19ee4e1d14d3 OK 2025/07/05 05:28:33 DEBUG : empty space: md5 = d083f4f639b60be834c7996f413ad7f0 OK 2025/07/05 05:28:33 DEBUG : Waiting for deletions to finish 2025/07/05 05:28:33 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:28:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:28:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:28:33 DEBUG : empty space: Unchanged skipping 2025/07/05 05:28:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:28:33 DEBUG : potato2: md5 = ee31cfd5d66d44d4292b77ca666b3445 OK 2025/07/05 05:28:33 INFO : potato2: Copied (new) 2025/07/05 05:28:46 INFO : potato: Deleted --- PASS: TestSyncDeleteDuring (34.79s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:29:02 DEBUG : potato: md5 = 3fc1ea463e69397f891fa4d4006bee11 OK 2025/07/05 05:29:08 DEBUG : empty space: md5 = 6bb520c2680fbadf91a847065ecdd563 OK 2025/07/05 05:29:13 DEBUG : Waiting for deletions to finish 2025/07/05 05:29:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:29:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:29:23 INFO : potato: Deleted 2025/07/05 05:29:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:29:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:29:23 DEBUG : potato2: md5 = 7f9ed7ad2456aa367194a1523cb46423 OK 2025/07/05 05:29:23 INFO : potato2: Copied (new) 2025/07/05 05:29:28 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:29:28 DEBUG : empty space: Unchanged skipping 2025/07/05 05:29:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish --- PASS: TestSyncDeleteBefore (41.66s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:29:44 DEBUG : potato: md5 = 7f4e43eb836d3b5a1dfc6199adb88e37 OK 2025/07/05 05:29:44 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:29:45 DEBUG : potato2: md5 = e8f2b19f8d14f013a8a8f2ebcd382543 OK 2025/07/05 05:29:45 INFO : potato2: Copied (new) 2025/07/05 05:29:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:29:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish --- PASS: TestCopyDeleteBefore (16.21s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:29:55 DEBUG : potato2: md5 = 6d9f133f8a5bfdb9da1fabc56c2083b9 OK 2025/07/05 05:30:00 DEBUG : empty space: md5 = 60a34cb917816331cb9b5ae9b6f1e41e OK 2025/07/05 05:30:01 DEBUG : enormous: Excluded (Size Filter) 2025/07/05 05:30:01 DEBUG : enormous: Excluded 2025/07/05 05:30:01 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 05:30:01 DEBUG : potato2: Excluded 2025/07/05 05:30:01 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 05:30:01 DEBUG : potato2: Excluded 2025/07/05 05:30:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:30:06 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:30:06 DEBUG : empty space: Unchanged skipping 2025/07/05 05:30:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:30:06 DEBUG : Waiting for deletions to finish 2025/07/05 05:30:06 INFO : There was nothing to transfer 2025/07/05 05:30:11 DEBUG : enormous: Excluded (Size Filter) 2025/07/05 05:30:11 DEBUG : enormous: Excluded 2025/07/05 05:30:11 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 05:30:11 DEBUG : potato2: Excluded 2025/07/05 05:30:11 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 05:30:11 DEBUG : potato2: Excluded 2025/07/05 05:30:11 DEBUG : Local file system at /tmp/rclone3868557063: Waiting for checks to finish 2025/07/05 05:30:11 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:30:11 DEBUG : empty space: Unchanged skipping 2025/07/05 05:30:11 DEBUG : Local file system at /tmp/rclone3868557063: Waiting for transfers to finish 2025/07/05 05:30:11 DEBUG : Waiting for deletions to finish 2025/07/05 05:30:11 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (29.54s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:30:25 DEBUG : potato2: md5 = 188d8264e9a3662c3c4ea28125dcd4d8 OK 2025/07/05 05:30:30 DEBUG : empty space: md5 = bd58d634d0de6ac6a6e9aaac556eaf87 OK 2025/07/05 05:30:31 DEBUG : enormous: md5 = b3b6662b849b3ecc95c8c003586dfa2f OK 2025/07/05 05:30:36 DEBUG : enormous: Excluded (Size Filter) 2025/07/05 05:30:36 DEBUG : enormous: Excluded 2025/07/05 05:30:36 DEBUG : potato2: Excluded (Size Filter) 2025/07/05 05:30:36 DEBUG : potato2: Excluded 2025/07/05 05:30:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:30:41 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:30:41 DEBUG : empty space: Unchanged skipping 2025/07/05 05:30:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:30:41 DEBUG : Waiting for deletions to finish 2025/07/05 05:30:41 INFO : potato2: Deleted 2025/07/05 05:30:41 INFO : enormous: Deleted 2025/07/05 05:30:41 INFO : There was nothing to transfer 2025/07/05 05:30:42 DEBUG : Local file system at /tmp/rclone3868557063: Waiting for checks to finish 2025/07/05 05:30:42 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:30:42 DEBUG : empty space: Unchanged skipping 2025/07/05 05:30:42 DEBUG : Local file system at /tmp/rclone3868557063: Waiting for transfers to finish 2025/07/05 05:30:42 DEBUG : Waiting for deletions to finish 2025/07/05 05:30:42 INFO : enormous: Deleted 2025/07/05 05:30:42 INFO : potato2: Deleted 2025/07/05 05:30:42 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (22.41s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:30:52 DEBUG : one: md5 = e85500a25bb55f29b06ad5bd4705d24f OK 2025/07/05 05:30:53 DEBUG : two: md5 = f0f54122abc32e9c54ef56b9d73acbc2 OK 2025/07/05 05:30:58 DEBUG : three: md5 = b3fb42fed6a6c842bb3405e3d3dd22d4 OK 2025/07/05 05:30:59 DEBUG : four: md5 = 076cbbc731fba1fbd1450fb79a43f1d7 OK 2025/07/05 05:30:59 DEBUG : five: Need to transfer - File not found at Destination 2025/07/05 05:30:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:30:59 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/07/05 05:30:59 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/07/05 05:30:59 DEBUG : one: Destination is newer than source, skipping 2025/07/05 05:31:00 DEBUG : four: md5 = 79f9cd719bdfcc4eea08e21de4090fbf OK 2025/07/05 05:31:00 INFO : four: Copied (replaced existing) 2025/07/05 05:31:00 DEBUG : two: md5 = 1deb13e3ef52fc47c7d3bae969063e74 OK 2025/07/05 05:31:00 INFO : two: Copied (replaced existing) 2025/07/05 05:31:04 DEBUG : three: Sizes identical 2025/07/05 05:31:04 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/07/05 05:31:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:31:05 DEBUG : five: md5 = dafcd83e23118682500d1704055327d1 OK 2025/07/05 05:31:05 INFO : five: Copied (new) 2025/07/05 05:31:05 DEBUG : Waiting for deletions to finish sync_test.go:1479: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (39.02s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1496: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1496: 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-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:1568: Can track renames: false 2025/07/05 05:31:26 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Ignoring --track-renames as the source and destination do not have a common hash 2025/07/05 05:31:26 DEBUG : potato: Need to transfer - File not found at Destination 2025/07/05 05:31:26 DEBUG : yam: Need to transfer - File not found at Destination 2025/07/05 05:31:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:31:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:31:31 DEBUG : potato: md5 = c6a16bef9a89215c0f6ad0558b111181 OK 2025/07/05 05:31:31 INFO : potato: Copied (new) 2025/07/05 05:31:31 DEBUG : yam: md5 = 713e34564ecd0c7b94d889a97e6990a8 OK 2025/07/05 05:31:31 INFO : yam: Copied (new) 2025/07/05 05:31:31 DEBUG : Waiting for deletions to finish 2025/07/05 05:31:32 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Ignoring --track-renames as the source and destination do not have a common hash 2025/07/05 05:31:32 DEBUG : yaml: Need to transfer - File not found at Destination 2025/07/05 05:31:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:31:34 DEBUG : yaml: md5 = 58610f4c945a8cccd19a20e304f6fb38 OK 2025/07/05 05:31:34 INFO : yaml: Copied (new) 2025/07/05 05:31:37 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:31:37 DEBUG : potato: Unchanged skipping 2025/07/05 05:31:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:31:37 DEBUG : Waiting for deletions to finish 2025/07/05 05:31:42 INFO : yam: Deleted --- PASS: TestSyncWithTrackRenames (31.57s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:1640: Can track renames: true 2025/07/05 05:31:58 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Making map for --track-renames 2025/07/05 05:31:58 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Finished making map for --track-renames 2025/07/05 05:31:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:31:58 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/05 05:31:58 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/05 05:31:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for renames to finish 2025/07/05 05:31:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:32:03 DEBUG : potato: md5 = 8f42395f687ce5c0a00852796aad5245 OK 2025/07/05 05:32:03 INFO : potato: Copied (new) 2025/07/05 05:32:03 DEBUG : yam: md5 = 37a602c27e469f308e70f02f1d0c98d0 OK 2025/07/05 05:32:03 INFO : yam: Copied (new) 2025/07/05 05:32:03 DEBUG : Waiting for deletions to finish 2025/07/05 05:32:09 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Making map for --track-renames 2025/07/05 05:32:09 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Finished making map for --track-renames 2025/07/05 05:32:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:32:14 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:32:14 DEBUG : potato: Unchanged skipping 2025/07/05 05:32:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for renames to finish 2025/07/05 05:32:24 INFO : yam: Copied (server-side copy) to: yaml 2025/07/05 05:32:29 INFO : yam: Deleted 2025/07/05 05:32:29 INFO : yaml: Renamed from "yam" 2025/07/05 05:32:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:32:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (37.19s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:1679: Can track renames: true 2025/07/05 05:32:35 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Making map for --track-renames 2025/07/05 05:32:35 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Finished making map for --track-renames 2025/07/05 05:32:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:32:35 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/05 05:32:35 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/07/05 05:32:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for renames to finish 2025/07/05 05:32:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:32:40 DEBUG : potato: md5 = 23db4b278ca36562631b69600020c33d OK 2025/07/05 05:32:40 INFO : potato: Copied (new) 2025/07/05 05:32:41 DEBUG : sub/yam: md5 = 0aa264b2e30ed752d8c8714bab1387c0 OK 2025/07/05 05:32:41 INFO : sub/yam: Copied (new) 2025/07/05 05:32:41 DEBUG : Waiting for deletions to finish 2025/07/05 05:32:51 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:32:51 DEBUG : potato: Unchanged skipping 2025/07/05 05:32:51 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Making map for --track-renames 2025/07/05 05:32:51 INFO : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Finished making map for --track-renames 2025/07/05 05:32:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:32:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for renames to finish 2025/07/05 05:33:16 INFO : sub/yam: Copied (server-side copy) to: yam 2025/07/05 05:33:22 INFO : sub/yam: Deleted 2025/07/05 05:33:22 INFO : yam: Renamed from "sub/yam" 2025/07/05 05:33:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:33:22 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (62.47s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:33:37 DEBUG : Creating backend with remote "/tmp/rclone3868557063/dir1" 2025/07/05 05:33:37 DEBUG : Config file has changed externally - reloading 2025/07/05 05:33:37 DEBUG : Creating backend with remote "/tmp/rclone3868557063/dir2" 2025/07/05 05:33:37 DEBUG : Local file system at /tmp/rclone3868557063/dir2: Using server-side directory move 2025/07/05 05:33:37 INFO : Local file system at /tmp/rclone3868557063/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/05 05:33:37 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/07/05 05:33:37 DEBUG : Local file system at /tmp/rclone3868557063/dir2: Waiting for checks to finish 2025/07/05 05:33:37 DEBUG : Local file system at /tmp/rclone3868557063/dir2: Waiting for transfers to finish 2025/07/05 05:33:37 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.37s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:33:38 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:33:38 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/05 05:33:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:33:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:33:43 DEBUG : sub dir/hello world: md5 = ab31c74e8e7a626d4a68d06340ecba83 OK 2025/07/05 05:33:43 INFO : sub dir/hello world: Copied (new) 2025/07/05 05:33:43 INFO : sub dir/hello world: Deleted 2025/07/05 05:33:44 DEBUG : nested/sub dir/file: md5 = 324203a295afeaa9f540ed925b6c644c OK 2025/07/05 05:33:44 INFO : nested/sub dir/file: Copied (new) 2025/07/05 05:33:44 INFO : nested/sub dir/file: Deleted 2025/07/05 05:33:44 INFO : sub dir: Removing directory 2025/07/05 05:33:44 INFO : nested/sub dir: Removing directory 2025/07/05 05:33:44 INFO : nested: Removing directory 2025/07/05 05:33:44 DEBUG : Local file system at /tmp/rclone3868557063: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (21.55s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:33:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/05 05:33:59 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/05 05:33:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:33:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:34:05 DEBUG : nested/sub dir/file: md5 = 82f3574b80e76797049ef65043572858 OK 2025/07/05 05:34:05 DEBUG : sub dir/hello world: md5 = bc3a7bd7aa81feed50fe709416f18028 OK 2025/07/05 05:34:05 INFO : nested/sub dir/file: Copied (new) 2025/07/05 05:34:05 INFO : sub dir/hello world: Copied (new) 2025/07/05 05:34:05 INFO : nested/sub dir/file: Deleted 2025/07/05 05:34:05 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (21.76s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:34:21 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/07/05 05:34:21 DEBUG : existing: Need to transfer - File not found at Destination 2025/07/05 05:34:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:34:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:34:27 DEBUG : existing-b: md5 = bae6e6cac99051ad95f88770f3f6430a OK 2025/07/05 05:34:27 INFO : existing-b: Copied (new) 2025/07/05 05:34:27 INFO : existing-b: Deleted 2025/07/05 05:34:27 DEBUG : existing: md5 = b6d4456b3ea69ae5027bee80119099c4 OK 2025/07/05 05:34:27 INFO : existing: Copied (new) 2025/07/05 05:34:27 INFO : existing: Deleted 2025/07/05 05:34:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:34:28 DEBUG : existing: Destination exists, skipping 2025/07/05 05:34:33 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/07/05 05:34:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:34:33 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (25.48s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:34:47 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-werobeq3zujo" 2025/07/05 05:34:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-werobeq3zujo.bin" 2025/07/05 05:34:47 DEBUG : Swift container crypt path rclone-test-werobeq3zujo.bin: Auto set use_segments_container to true 2025/07/05 05:34:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-werobeq3zujo" 2025/07/05 05:34:52 DEBUG : Swift container crypt path rclone-test-werobeq3zujo: Auto set use_segments_container to true 2025/07/05 05:34:58 DEBUG : potato2: md5 = b73942ca9b88b3b4c5f7f51ccdad69df OK 2025/07/05 05:35:03 DEBUG : empty space: md5 = 18e00665eb8e4e622dfd2d3705ff109d OK 2025/07/05 05:35:09 DEBUG : potato3: md5 = 0a42b9bbebd292b7078444506abbfc0d OK sync_test.go:1735: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa' -> Encrypted drive 'TestCryptSwift:rclone-test-werobeq3zujo' 2025/07/05 05:35:15 DEBUG : empty space: md5 = 35decbea0a381f686c79661055387b8e OK 2025/07/05 05:35:15 DEBUG : potato3: md5 = 4e500abb4739face968c9c0bfb959c52 OK 2025/07/05 05:35:20 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:35:20 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/05 05:35:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-werobeq3zujo': Waiting for checks to finish 2025/07/05 05:35:25 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:35:25 DEBUG : empty space: Unchanged skipping 2025/07/05 05:35:26 INFO : potato3: Copied (server-side copy) 2025/07/05 05:35:30 INFO : empty space: Deleted 2025/07/05 05:35:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-werobeq3zujo': Waiting for transfers to finish 2025/07/05 05:35:31 INFO : potato3: Deleted 2025/07/05 05:35:31 INFO : potato2: Copied (server-side copy) 2025/07/05 05:35:31 INFO : potato2: Deleted 2025/07/05 05:35:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zoyudom5nosu" 2025/07/05 05:35:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zoyudom5nosu.bin" 2025/07/05 05:35:32 DEBUG : Swift container crypt path rclone-test-zoyudom5nosu.bin: Auto set use_segments_container to true 2025/07/05 05:35:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zoyudom5nosu" 2025/07/05 05:35:38 DEBUG : Swift container crypt path rclone-test-zoyudom5nosu: Auto set use_segments_container to true 2025/07/05 05:35:44 DEBUG : empty space: Need to transfer - File not found at Destination 2025/07/05 05:35:44 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:35:44 DEBUG : potato3: Need to transfer - File not found at Destination 2025/07/05 05:35:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zoyudom5nosu': Waiting for checks to finish 2025/07/05 05:35:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zoyudom5nosu': Waiting for transfers to finish 2025/07/05 05:35:49 INFO : potato3: Copied (server-side copy) 2025/07/05 05:35:49 INFO : potato3: Deleted 2025/07/05 05:35:49 INFO : potato2: Copied (server-side copy) 2025/07/05 05:35:54 INFO : empty space: Copied (server-side copy) 2025/07/05 05:35:54 INFO : potato2: Deleted 2025/07/05 05:35:59 INFO : empty space: Deleted 2025/07/05 05:36:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zoyudom5nosu': Purge remote 2025/07/05 05:36:05 DEBUG : Waiting for deletions to finish 2025/07/05 05:36:05 INFO : potato3.bin: Deleted 2025/07/05 05:36:05 INFO : potato2.bin: Deleted 2025/07/05 05:36:10 INFO : empty space.bin: Deleted 2025/07/05 05:36:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-werobeq3zujo': Purge remote 2025/07/05 05:36:10 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (83.57s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:36:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kelagew4qoca" 2025/07/05 05:36:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kelagew4qoca.bin" 2025/07/05 05:36:11 DEBUG : Swift container crypt path rclone-test-kelagew4qoca.bin: Auto set use_segments_container to true 2025/07/05 05:36:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kelagew4qoca" 2025/07/05 05:36:16 DEBUG : Swift container crypt path rclone-test-kelagew4qoca: Auto set use_segments_container to true 2025/07/05 05:36:22 DEBUG : potato2: md5 = fa260a96e9f38b53548953b664aac2d2 OK 2025/07/05 05:36:27 DEBUG : empty space: md5 = f8223385f9126883bd5eb538de04d279 OK 2025/07/05 05:36:32 DEBUG : potato3: md5 = 09b45e9cc0bc22583a11fda5131fbfbb OK sync_test.go:1735: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa' -> Encrypted drive 'TestCryptSwift:rclone-test-kelagew4qoca' 2025/07/05 05:36:48 DEBUG : empty space: md5 = fe910f35ad6cc1de29ea7eccab2925c5 OK 2025/07/05 05:36:53 DEBUG : potato3: md5 = ea78cf387f569b5791adedaa5f7392ef OK 2025/07/05 05:36:54 DEBUG : empty space: Excluded (Size Filter) 2025/07/05 05:36:54 DEBUG : empty space: Excluded 2025/07/05 05:36:54 DEBUG : empty space: Excluded (Size Filter) 2025/07/05 05:36:54 DEBUG : empty space: Excluded 2025/07/05 05:36:54 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:36:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kelagew4qoca': Waiting for checks to finish 2025/07/05 05:36:54 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/05 05:36:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kelagew4qoca': Waiting for transfers to finish 2025/07/05 05:37:04 INFO : potato3: Copied (server-side copy) 2025/07/05 05:37:09 INFO : potato2: Copied (server-side copy) 2025/07/05 05:37:09 INFO : potato2: Deleted 2025/07/05 05:37:09 INFO : potato3: Deleted 2025/07/05 05:37:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-saciguf8xoxi" 2025/07/05 05:37:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-saciguf8xoxi.bin" 2025/07/05 05:37:20 DEBUG : Swift container crypt path rclone-test-saciguf8xoxi.bin: Auto set use_segments_container to true 2025/07/05 05:37:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-saciguf8xoxi" 2025/07/05 05:37:26 DEBUG : Swift container crypt path rclone-test-saciguf8xoxi: Auto set use_segments_container to true 2025/07/05 05:37:31 DEBUG : empty space: Excluded (Size Filter) 2025/07/05 05:37:31 DEBUG : empty space: Excluded 2025/07/05 05:37:31 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:37:31 DEBUG : potato3: Need to transfer - File not found at Destination 2025/07/05 05:37:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-saciguf8xoxi': Waiting for checks to finish 2025/07/05 05:37:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-saciguf8xoxi': Waiting for transfers to finish 2025/07/05 05:37:42 INFO : potato3: Copied (server-side copy) 2025/07/05 05:37:47 INFO : potato3: Deleted 2025/07/05 05:37:51 INFO : potato2: Copied (server-side copy) 2025/07/05 05:37:57 INFO : potato2: Deleted 2025/07/05 05:37:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-saciguf8xoxi': Purge remote 2025/07/05 05:37:57 DEBUG : Waiting for deletions to finish 2025/07/05 05:38:02 INFO : potato3.bin: Deleted 2025/07/05 05:38:07 INFO : potato2.bin: Deleted 2025/07/05 05:38:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kelagew4qoca': Purge remote 2025/07/05 05:38:07 DEBUG : Waiting for deletions to finish 2025/07/05 05:38:13 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (127.87s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:38:18 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-cuzaluc2xipo" 2025/07/05 05:38:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-cuzaluc2xipo.bin" 2025/07/05 05:38:18 DEBUG : Swift container crypt path rclone-test-cuzaluc2xipo.bin: Auto set use_segments_container to true 2025/07/05 05:38:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-cuzaluc2xipo" 2025/07/05 05:38:29 DEBUG : Swift container crypt path rclone-test-cuzaluc2xipo: Auto set use_segments_container to true 2025/07/05 05:38:34 DEBUG : potato2: md5 = 9be2d00ba51c1894a887a58f90b964a3 OK 2025/07/05 05:38:40 DEBUG : empty space: md5 = 95bee9d184af4f3b41a238f8466f35d7 OK 2025/07/05 05:38:45 DEBUG : potato3: md5 = dd408b49a855f9d77c1a92c90de897b4 OK 2025/07/05 05:38:45 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa' -> Encrypted drive 'TestCryptSwift:rclone-test-cuzaluc2xipo' 2025/07/05 05:38:55 DEBUG : empty space: md5 = 7c149c66578fd211098e150685253985 OK 2025/07/05 05:39:01 DEBUG : potato3: md5 = 50968800f3a06f0912b4dfd8941efc73 OK 2025/07/05 05:39:01 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:39:01 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/05 05:39:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-cuzaluc2xipo': Waiting for checks to finish 2025/07/05 05:39:11 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:39:11 DEBUG : empty space: Unchanged skipping 2025/07/05 05:39:12 INFO : potato2: Copied (server-side copy) 2025/07/05 05:39:12 INFO : potato2: Deleted 2025/07/05 05:39:16 INFO : empty space: Deleted 2025/07/05 05:39:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-cuzaluc2xipo': Waiting for transfers to finish 2025/07/05 05:39:21 INFO : potato3: Copied (server-side copy) 2025/07/05 05:39:26 INFO : potato3: Deleted 2025/07/05 05:39:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yijujic6bili" 2025/07/05 05:39:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yijujic6bili.bin" 2025/07/05 05:39:32 DEBUG : Swift container crypt path rclone-test-yijujic6bili.bin: Auto set use_segments_container to true 2025/07/05 05:39:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yijujic6bili" 2025/07/05 05:39:38 DEBUG : Swift container crypt path rclone-test-yijujic6bili: Auto set use_segments_container to true 2025/07/05 05:39:43 INFO : tomatoDir: Making directory 2025/07/05 05:39:43 DEBUG : empty space: Need to transfer - File not found at Destination 2025/07/05 05:39:43 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/05 05:39:43 DEBUG : potato3: Need to transfer - File not found at Destination 2025/07/05 05:39:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yijujic6bili': Waiting for checks to finish 2025/07/05 05:39:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yijujic6bili': Waiting for transfers to finish 2025/07/05 05:39:54 INFO : potato2: Copied (server-side copy) 2025/07/05 05:39:54 INFO : empty space: Copied (server-side copy) 2025/07/05 05:39:59 INFO : potato2: Deleted 2025/07/05 05:39:59 INFO : potato3: Copied (server-side copy) 2025/07/05 05:39:59 INFO : empty space: Deleted 2025/07/05 05:40:04 INFO : potato3: Deleted 2025/07/05 05:40:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yijujic6bili': Purge remote 2025/07/05 05:40:10 DEBUG : Waiting for deletions to finish 2025/07/05 05:40:10 INFO : empty space.bin: Deleted 2025/07/05 05:40:20 INFO : potato3.bin: Deleted 2025/07/05 05:40:20 INFO : potato2.bin: Deleted 2025/07/05 05:40:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-cuzaluc2xipo': Purge remote 2025/07/05 05:40:20 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (122.46s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:40:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-move-test" 2025/07/05 05:40:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-move-test.bin" 2025/07/05 05:40:21 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-move-test.bin: Auto set use_segments_container to true 2025/07/05 05:40:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-move-test" 2025/07/05 05:40:27 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-move-test: Auto set use_segments_container to true 2025/07/05 05:40:35 DEBUG : potato2: md5 = a4bb31c8b1ef17a0d871fc0073cc123a OK --- PASS: TestServerSideMoveOverlap (15.33s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:40:36 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test" 2025/07/05 05:40:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-sync-test.bin" 2025/07/05 05:40:36 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-sync-test.bin: Auto set use_segments_container to true 2025/07/05 05:40:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-sync-test" 2025/07/05 05:40:47 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-sync-test: Auto set use_segments_container to true --- PASS: TestSyncOverlap (16.40s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:40:52 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test" 2025/07/05 05:40:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-sync-test.bin" 2025/07/05 05:40:53 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-sync-test.bin: Auto set use_segments_container to true 2025/07/05 05:41:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-sync-test" 2025/07/05 05:41:03 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-sync-test: Auto set use_segments_container to true 2025/07/05 05:41:08 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test-include/layer2" 2025/07/05 05:41:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-sync-test-include/layer2.bin" 2025/07/05 05:41:09 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/07/05 05:41:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-sync-test-include/layer2" 2025/07/05 05:41:29 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/07/05 05:41:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test-ignore-file" 2025/07/05 05:41:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-sync-test-ignore-file.bin" 2025/07/05 05:41:35 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/07/05 05:41:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/rclone-sync-test-ignore-file" 2025/07/05 05:41:56 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/07/05 05:42:07 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = cefc7454efa92d9f97dfac7b305d5675 OK 2025/07/05 05:42:13 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 05:42:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test': Waiting for checks to finish 2025/07/05 05:42:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test': Waiting for transfers to finish 2025/07/05 05:42:13 DEBUG : Waiting for deletions to finish 2025/07/05 05:42:13 INFO : There was nothing to transfer 2025/07/05 05:42:18 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 05:42:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:42:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:42:18 DEBUG : Waiting for deletions to finish 2025/07/05 05:42:18 INFO : There was nothing to transfer 2025/07/05 05:42:23 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 05:42:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/07/05 05:42:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/07/05 05:42:23 DEBUG : Waiting for deletions to finish 2025/07/05 05:42:23 INFO : There was nothing to transfer 2025/07/05 05:42:28 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 05:42:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:42:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:42:28 DEBUG : Waiting for deletions to finish 2025/07/05 05:42:28 INFO : There was nothing to transfer 2025/07/05 05:42:34 DEBUG : Excluded 2025/07/05 05:42:34 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/07/05 05:42:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/07/05 05:42:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/07/05 05:42:34 DEBUG : Waiting for deletions to finish 2025/07/05 05:42:34 INFO : There was nothing to transfer --- PASS: TestSyncOverlapWithFilter (112.77s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:42:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:42:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst.bin" 2025/07/05 05:42:45 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst.bin: Auto set use_segments_container to true 2025/07/05 05:43:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:43:06 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst: Auto set use_segments_container to true 2025/07/05 05:43:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/CompareDest" 2025/07/05 05:43:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/CompareDest.bin" 2025/07/05 05:43:12 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/CompareDest.bin: Auto set use_segments_container to true 2025/07/05 05:43:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/CompareDest" 2025/07/05 05:43:17 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/CompareDest: Auto set use_segments_container to true 2025/07/05 05:43:43 DEBUG : one: Need to transfer - File not found at Destination 2025/07/05 05:43:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:43:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:43:44 DEBUG : one: md5 = 094e5ac53d04ecb9fa5d1c4d57b6dbf9 OK 2025/07/05 05:43:44 INFO : one: Copied (new) 2025/07/05 05:43:44 DEBUG : Waiting for deletions to finish 2025/07/05 05:43:44 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 05:43:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:43:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:43:50 DEBUG : one: md5 = 0df76eb017dd18091c6f14204fcc94c0 OK 2025/07/05 05:43:50 INFO : one: Copied (replaced existing) 2025/07/05 05:43:50 DEBUG : Waiting for deletions to finish 2025/07/05 05:43:50 DEBUG : dst/one: md5 = dde66f2790b614d00860635161dcdec1 OK 2025/07/05 05:43:55 DEBUG : CompareDest/one: md5 = e2ad254c144edb311080ed618f2547bf OK 2025/07/05 05:44:01 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 05:44:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:44:01 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:44:01 DEBUG : one: Destination found in --compare-dest, skipping 2025/07/05 05:44:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:44:01 DEBUG : Waiting for deletions to finish 2025/07/05 05:44:01 INFO : There was nothing to transfer 2025/07/05 05:44:02 DEBUG : CompareDest/two: md5 = c87db00bc2dae225ada5644650484de4 OK 2025/07/05 05:44:07 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 05:44:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:44:07 DEBUG : two: Destination found in --compare-dest, skipping 2025/07/05 05:44:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:44:12 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:44:12 DEBUG : one: Destination found in --compare-dest, skipping 2025/07/05 05:44:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:44:12 DEBUG : Waiting for deletions to finish 2025/07/05 05:44:12 INFO : There was nothing to transfer 2025/07/05 05:44:13 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 05:44:13 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:44:13 DEBUG : two: Destination found in --compare-dest, skipping 2025/07/05 05:44:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:44:13 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:44:13 DEBUG : one: Destination found in --compare-dest, skipping 2025/07/05 05:44:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:44:13 DEBUG : Waiting for deletions to finish 2025/07/05 05:44:13 INFO : There was nothing to transfer sync_test.go:2205: No hash on uploaded file so skipping compare timestamp test 2025/07/05 05:44:18 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 05:44:18 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/07/05 05:44:18 DEBUG : two: Need to transfer - File not found at Destination 2025/07/05 05:44:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:44:19 DEBUG : two: md5 = 68ffdfff7811254e83cc85fc18967163 OK 2025/07/05 05:44:19 INFO : two: Copied (new) 2025/07/05 05:44:23 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:44:23 DEBUG : one: Destination found in --compare-dest, skipping 2025/07/05 05:44:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:44:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (109.82s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:44:40 DEBUG : pre-dest1/1: md5 = 075186f1746df1cf229b3a900b9be844 OK 2025/07/05 05:44:41 DEBUG : pre-dest2/2: md5 = b1a0a4ded6059b750b51f5caa9bdd288 OK 2025/07/05 05:44:41 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/dest" 2025/07/05 05:44:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dest.bin" 2025/07/05 05:44:42 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dest.bin: Auto set use_segments_container to true 2025/07/05 05:44:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dest" 2025/07/05 05:44:47 DEBUG : Config file has changed externally - reloading 2025/07/05 05:44:47 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dest: Auto set use_segments_container to true 2025/07/05 05:44:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/pre-dest1" 2025/07/05 05:44:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/pre-dest1.bin" 2025/07/05 05:44:53 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/pre-dest1.bin: Auto set use_segments_container to true 2025/07/05 05:44:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/pre-dest1" 2025/07/05 05:44:59 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/pre-dest1: Auto set use_segments_container to true 2025/07/05 05:45:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/pre-dest2" 2025/07/05 05:45:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/pre-dest2.bin" 2025/07/05 05:45:04 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/pre-dest2.bin: Auto set use_segments_container to true 2025/07/05 05:45:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/pre-dest2" 2025/07/05 05:45:10 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/pre-dest2: Auto set use_segments_container to true 2025/07/05 05:45:16 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:45:16 DEBUG : 1: Destination found in --compare-dest, skipping 2025/07/05 05:45:21 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:45:21 DEBUG : 2: Destination found in --compare-dest, skipping 2025/07/05 05:45:31 DEBUG : 3: Need to transfer - File not found at Destination 2025/07/05 05:45:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dest': Waiting for checks to finish 2025/07/05 05:45:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dest': Waiting for transfers to finish 2025/07/05 05:45:32 DEBUG : 3: md5 = 827824ddb38d98802e829475336e651b OK 2025/07/05 05:45:32 INFO : 3: Copied (new) 2025/07/05 05:45:32 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (64.07s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:45:39 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:45:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst.bin" 2025/07/05 05:45:39 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst.bin: Auto set use_segments_container to true 2025/07/05 05:45:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:45:45 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst: Auto set use_segments_container to true 2025/07/05 05:45:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/CopyDest" 2025/07/05 05:45:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/CopyDest.bin" 2025/07/05 05:45:50 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/CopyDest.bin: Auto set use_segments_container to true 2025/07/05 05:45:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/CopyDest" 2025/07/05 05:45:56 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/CopyDest: Auto set use_segments_container to true 2025/07/05 05:46:07 DEBUG : one: Need to transfer - File not found at Destination 2025/07/05 05:46:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:46:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:46:07 DEBUG : one: md5 = 6b13379678927561f5f8211963ea7e79 OK 2025/07/05 05:46:07 INFO : one: Copied (new) 2025/07/05 05:46:07 DEBUG : Waiting for deletions to finish 2025/07/05 05:46:08 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 05:46:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:46:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:46:13 DEBUG : one: md5 = ce2239faa0635c7e060365093c06b87f OK 2025/07/05 05:46:13 INFO : one: Copied (replaced existing) 2025/07/05 05:46:13 DEBUG : Waiting for deletions to finish 2025/07/05 05:46:14 DEBUG : dst/one: md5 = 32120a713a4c0491f0da4864e7376388 OK 2025/07/05 05:46:14 DEBUG : CopyDest/one: md5 = 40c2c0974c90b142d129200df488474c OK 2025/07/05 05:46:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/BackupDir" 2025/07/05 05:46:14 DEBUG : Config file has changed externally - reloading 2025/07/05 05:46:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/BackupDir.bin" 2025/07/05 05:46:14 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/BackupDir.bin: Auto set use_segments_container to true 2025/07/05 05:46:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/BackupDir" 2025/07/05 05:46:20 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/BackupDir: Auto set use_segments_container to true 2025/07/05 05:46:26 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 05:46:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:46:26 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:46:26 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/07/05 05:46:42 INFO : one: Copied (server-side copy) 2025/07/05 05:46:42 INFO : one: Deleted 2025/07/05 05:46:47 INFO : one: Copied (server-side copy) 2025/07/05 05:46:47 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/07/05 05:46:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:46:47 DEBUG : Waiting for deletions to finish 2025/07/05 05:46:53 DEBUG : CopyDest/two: md5 = 571fb5e46a697bdb454e33cce8af2e85 OK 2025/07/05 05:46:58 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:46:58 DEBUG : one: Unchanged skipping 2025/07/05 05:47:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:47:08 INFO : two: Copied (server-side copy) 2025/07/05 05:47:08 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/07/05 05:47:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:47:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:47:08 DEBUG : Waiting for deletions to finish 2025/07/05 05:47:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:47:14 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:47:14 DEBUG : one: Unchanged skipping 2025/07/05 05:47:14 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:47:14 DEBUG : two: Unchanged skipping 2025/07/05 05:47:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:47:14 DEBUG : Waiting for deletions to finish 2025/07/05 05:47:14 INFO : There was nothing to transfer 2025/07/05 05:47:20 DEBUG : CopyDest/three: md5 = 114565208ad9b6b1f24a47f31a750331 OK 2025/07/05 05:47:30 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:47:30 DEBUG : one: Unchanged skipping 2025/07/05 05:47:35 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/07/05 05:47:35 DEBUG : three: Destination not found in --copy-dest 2025/07/05 05:47:35 DEBUG : three: Need to transfer - File not found at Destination 2025/07/05 05:47:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:47:35 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:47:35 DEBUG : two: Unchanged skipping 2025/07/05 05:47:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:47:36 DEBUG : three: md5 = 93236dfd8eb2dae34d2416a1a5551be9 OK 2025/07/05 05:47:36 INFO : three: Copied (new) 2025/07/05 05:47:36 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (149.08s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:48:08 DEBUG : dst/one: md5 = 44e5ded002dc14767f6952adfffa7f5d OK 2025/07/05 05:48:08 DEBUG : dst/two: md5 = 5d6a276704ae07a2cf5643df5ef45fe6 OK 2025/07/05 05:48:09 DEBUG : dst/three.txt: md5 = 569f61937e4ad16851c6fdcaa8b783e3 OK 2025/07/05 05:48:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:48:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst.bin" 2025/07/05 05:48:09 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst.bin: Auto set use_segments_container to true 2025/07/05 05:48:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:48:15 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst: Auto set use_segments_container to true 2025/07/05 05:48:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/backup" 2025/07/05 05:48:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/backup.bin" 2025/07/05 05:48:21 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/backup.bin: Auto set use_segments_container to true 2025/07/05 05:48:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/backup" 2025/07/05 05:48:26 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/backup: Auto set use_segments_container to true 2025/07/05 05:48:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 05:48:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:48:32 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:48:32 DEBUG : two: Unchanged skipping 2025/07/05 05:48:42 INFO : one: Copied (server-side copy) 2025/07/05 05:48:42 INFO : one: Deleted 2025/07/05 05:48:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:48:43 DEBUG : one: md5 = af55df91910bcc6da282f8db0738a59c OK 2025/07/05 05:48:43 INFO : one: Copied (new) 2025/07/05 05:48:43 DEBUG : Waiting for deletions to finish 2025/07/05 05:48:53 INFO : three.txt: Copied (server-side copy) 2025/07/05 05:48:53 INFO : three.txt: Deleted 2025/07/05 05:48:53 INFO : three.txt: Moved into backup dir 2025/07/05 05:48:54 DEBUG : dst/three.txt: md5 = e884c1531f65b96c426a583495622cda OK 2025/07/05 05:48:54 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 05:48:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:48:54 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:48:54 DEBUG : two: Unchanged skipping 2025/07/05 05:49:00 INFO : one: Copied (server-side copy) 2025/07/05 05:49:00 INFO : one: Deleted 2025/07/05 05:49:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:49:00 DEBUG : one: md5 = ced0fecfa323f718d05805e356bc2cd7 OK 2025/07/05 05:49:00 INFO : one: Copied (new) 2025/07/05 05:49:00 DEBUG : Waiting for deletions to finish 2025/07/05 05:49:05 INFO : three.txt: Copied (server-side copy) 2025/07/05 05:49:06 INFO : three.txt: Deleted 2025/07/05 05:49:06 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (59.05s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:49:07 DEBUG : dst/one: md5 = 13879efc19e9c37f9df4083c1126be07 OK 2025/07/05 05:49:07 DEBUG : dst/two: md5 = f04e3763e8559e656fa92144f8e04faa OK 2025/07/05 05:49:07 DEBUG : dst/three.txt: md5 = 5cd2abadca77d7e571ddf1f0e14251ac OK 2025/07/05 05:49:08 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:49:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst.bin" 2025/07/05 05:49:08 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst.bin: Auto set use_segments_container to true 2025/07/05 05:49:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:49:14 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst: Auto set use_segments_container to true 2025/07/05 05:49:19 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/backup" 2025/07/05 05:49:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/backup.bin" 2025/07/05 05:49:19 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/backup.bin: Auto set use_segments_container to true 2025/07/05 05:49:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/backup" 2025/07/05 05:49:25 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/backup: Auto set use_segments_container to true 2025/07/05 05:49:30 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 05:49:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:49:30 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:49:30 DEBUG : two: Unchanged skipping 2025/07/05 05:49:46 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 05:49:46 INFO : one: Deleted 2025/07/05 05:49:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:49:46 DEBUG : one: md5 = 5399f229d396e3e225becb166da19cdc OK 2025/07/05 05:49:46 INFO : one: Copied (new) 2025/07/05 05:49:46 DEBUG : Waiting for deletions to finish 2025/07/05 05:50:02 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 05:50:02 INFO : three.txt: Deleted 2025/07/05 05:50:02 INFO : three.txt: Moved into backup dir 2025/07/05 05:50:08 DEBUG : dst/three.txt: md5 = 9b5c553ba97e3183c6ef275edee77f55 OK 2025/07/05 05:50:13 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 05:50:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:50:13 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:50:13 DEBUG : two: Unchanged skipping 2025/07/05 05:50:23 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 05:50:24 INFO : one: Deleted 2025/07/05 05:50:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:50:24 DEBUG : one: md5 = cf7f4c58c1bea7383ca22e6b249fc235 OK 2025/07/05 05:50:24 INFO : one: Copied (new) 2025/07/05 05:50:24 DEBUG : Waiting for deletions to finish 2025/07/05 05:50:34 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 05:50:34 INFO : three.txt: Deleted 2025/07/05 05:50:34 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (113.53s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:51:01 DEBUG : dst/one: md5 = 5b1e6b6d6c87680698d4e2e75c6af17e OK 2025/07/05 05:51:01 DEBUG : dst/two: md5 = c6c605394a81cee0dbb1781a12bb6437 OK 2025/07/05 05:51:01 DEBUG : dst/three.txt: md5 = 5261ab86dd92c797285521a098789376 OK 2025/07/05 05:51:01 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:51:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst.bin" 2025/07/05 05:51:02 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst.bin: Auto set use_segments_container to true 2025/07/05 05:51:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:51:07 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst: Auto set use_segments_container to true 2025/07/05 05:51:12 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/backup" 2025/07/05 05:51:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/backup.bin" 2025/07/05 05:51:13 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/backup.bin: Auto set use_segments_container to true 2025/07/05 05:51:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/backup" 2025/07/05 05:51:18 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/backup: Auto set use_segments_container to true 2025/07/05 05:51:24 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 05:51:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:51:24 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:51:24 DEBUG : two: Unchanged skipping 2025/07/05 05:51:40 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/07/05 05:51:40 INFO : one: Deleted 2025/07/05 05:51:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:51:40 DEBUG : one: md5 = 2dcd138a6e7e2c9655df1ba062d9897c OK 2025/07/05 05:51:40 INFO : one: Copied (new) 2025/07/05 05:51:40 DEBUG : Waiting for deletions to finish 2025/07/05 05:51:51 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/07/05 05:51:51 INFO : three.txt: Deleted 2025/07/05 05:51:51 INFO : three.txt: Moved into backup dir 2025/07/05 05:51:52 DEBUG : dst/three.txt: md5 = 5206f74ddd3fa3895be1149b884da7d3 OK 2025/07/05 05:51:52 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 05:51:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:51:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:51:52 DEBUG : two: Unchanged skipping 2025/07/05 05:52:02 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/07/05 05:52:03 INFO : one: Deleted 2025/07/05 05:52:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:52:03 DEBUG : one: md5 = 8a55bcfbb29bedc06e287e5292bf370d OK 2025/07/05 05:52:03 INFO : one: Copied (new) 2025/07/05 05:52:03 DEBUG : Waiting for deletions to finish 2025/07/05 05:52:08 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/07/05 05:52:08 INFO : three.txt: Deleted 2025/07/05 05:52:08 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (74.05s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:52:15 DEBUG : dst/one: md5 = 6161f5097eb5f80ff541461dc097d9b0 OK 2025/07/05 05:52:15 DEBUG : dst/two: md5 = b94b19a426b033b222bd8dae58735268 OK 2025/07/05 05:52:15 DEBUG : dst/three.txt: md5 = f16ce144b1eec845ddd2339bfdc2f84f OK 2025/07/05 05:52:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:52:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst.bin" 2025/07/05 05:52:16 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst.bin: Auto set use_segments_container to true 2025/07/05 05:52:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:52:21 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst: Auto set use_segments_container to true 2025/07/05 05:52:27 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 05:52:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:52:27 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:52:27 DEBUG : two: Unchanged skipping 2025/07/05 05:52:42 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 05:52:43 INFO : one: Deleted 2025/07/05 05:52:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:52:43 DEBUG : one: md5 = 94785d604f4cc5396e9e18898f087c61 OK 2025/07/05 05:52:43 INFO : one: Copied (new) 2025/07/05 05:52:43 DEBUG : Waiting for deletions to finish 2025/07/05 05:53:03 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 05:53:03 INFO : three.txt: Deleted 2025/07/05 05:53:03 INFO : three.txt: Moved into backup dir 2025/07/05 05:53:04 DEBUG : dst/three.txt: md5 = dfcb2570f8f24a9294f7401358cc28a1 OK 2025/07/05 05:53:05 DEBUG : one.bak: Excluded (Path Filter) 2025/07/05 05:53:05 DEBUG : one.bak: Excluded 2025/07/05 05:53:05 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/07/05 05:53:05 DEBUG : three.txt.bak: Excluded 2025/07/05 05:53:05 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 05:53:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for checks to finish 2025/07/05 05:53:05 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:53:05 DEBUG : two: Unchanged skipping 2025/07/05 05:53:20 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 05:53:20 INFO : one: Deleted 2025/07/05 05:53:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa/dst': Waiting for transfers to finish 2025/07/05 05:53:20 DEBUG : one: md5 = 7ea67f7bcae689e10cf91f3f756f81a4 OK 2025/07/05 05:53:20 INFO : one: Copied (new) 2025/07/05 05:53:20 DEBUG : Waiting for deletions to finish 2025/07/05 05:53:31 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 05:53:31 INFO : three.txt: Deleted 2025/07/05 05:53:31 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (92.53s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:53:47 DEBUG : dst/one: md5 = 61d2d2c4379206f4af2da5eed83eed0e OK 2025/07/05 05:53:48 DEBUG : dst/two: md5 = cbe5b8ddfdb1d5777703833a448bb36d OK 2025/07/05 05:53:48 DEBUG : dst/three.txt: md5 = 2a19ec354c127c33695ef653fc2b3269 OK 2025/07/05 05:53:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:53:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst.bin" 2025/07/05 05:53:48 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst.bin: Auto set use_segments_container to true 2025/07/05 05:53:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:53:54 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst: Auto set use_segments_container to true 2025/07/05 05:53:59 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 05:54:15 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 05:54:15 INFO : one: Deleted 2025/07/05 05:54:16 DEBUG : one: md5 = 9d7ea9eee9ec9f5b7ac66b9e6738d47a OK 2025/07/05 05:54:16 INFO : one: Copied (new) 2025/07/05 05:54:16 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:54:16 DEBUG : two: Unchanged skipping 2025/07/05 05:54:16 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/07/05 05:54:36 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 05:54:36 INFO : three.txt: Deleted 2025/07/05 05:54:36 DEBUG : three.txt: md5 = 9d4760c8381f168f2dd65c9aa7bf6961 OK 2025/07/05 05:54:36 INFO : three.txt: Copied (new) 2025/07/05 05:54:42 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 05:54:57 INFO : one: Copied (server-side copy) to: one.bak 2025/07/05 05:54:57 INFO : one: Deleted 2025/07/05 05:54:58 DEBUG : one: md5 = bffda58e0b863766eccaf0507565a004 OK 2025/07/05 05:54:58 INFO : one: Copied (new) 2025/07/05 05:54:58 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:54:58 DEBUG : two: Unchanged skipping 2025/07/05 05:54:58 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/07/05 05:55:13 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/07/05 05:55:13 INFO : three.txt: Deleted 2025/07/05 05:55:13 DEBUG : three.txt: md5 = 85f7857563107509938766d45c3c3dca OK 2025/07/05 05:55:13 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (112.55s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:55:40 DEBUG : dst/one: md5 = 7e2ea2db64c6c016f960bccd43ee04c3 OK 2025/07/05 05:55:40 DEBUG : dst/two: md5 = 81200b7feefa4e512566fc2f278da78d OK 2025/07/05 05:55:40 DEBUG : dst/three.txt: md5 = e1c03ef28e4f9740fc5accd168622e2a OK 2025/07/05 05:55:41 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:55:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst.bin" 2025/07/05 05:55:41 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst.bin: Auto set use_segments_container to true 2025/07/05 05:55:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gayeyod2kaxa/dst" 2025/07/05 05:55:46 DEBUG : Swift container crypt path rclone-test-gayeyod2kaxa/dst: Auto set use_segments_container to true 2025/07/05 05:55:52 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/05 05:56:02 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/07/05 05:56:02 INFO : one: Deleted 2025/07/05 05:56:03 DEBUG : one: md5 = dc9eecd3be9a7d77a2dfb1de16ac6e33 OK 2025/07/05 05:56:03 INFO : one: Copied (new) 2025/07/05 05:56:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:56:03 DEBUG : two: Unchanged skipping 2025/07/05 05:56:03 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/07/05 05:56:13 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/07/05 05:56:13 INFO : three.txt: Deleted 2025/07/05 05:56:14 DEBUG : three.txt: md5 = eb375e12c4b58038b964ed3d9d6b7dc6 OK 2025/07/05 05:56:14 INFO : three.txt: Copied (new) 2025/07/05 05:56:14 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/07/05 05:56:20 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/07/05 05:56:20 INFO : one: Deleted 2025/07/05 05:56:20 DEBUG : one: md5 = 7c0d5250af2d3d56603a46000ad86885 OK 2025/07/05 05:56:20 INFO : one: Copied (new) 2025/07/05 05:56:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:56:20 DEBUG : two: Unchanged skipping 2025/07/05 05:56:20 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/07/05 05:56:25 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/07/05 05:56:26 INFO : three.txt: Deleted 2025/07/05 05:56:26 DEBUG : three.txt: md5 = 07ae83770c94c5802370015d2ce758f1 OK 2025/07/05 05:56:26 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (47.75s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:56:28 DEBUG : Testêé: md5 = 939b1d4bef3c02a234c86260ef4af099 OK 2025/07/05 05:56:28 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/07/05 05:56:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:56:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:56:28 DEBUG : Testêé: md5 = c41fb205cbde923dba70907d022f7643 OK 2025/07/05 05:56:28 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/07/05 05:56:28 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (2.29s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:56:30 DEBUG : existing: Need to transfer - File not found at Destination 2025/07/05 05:56:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:56:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:56:35 DEBUG : existing: md5 = 8887de68758df27869ae8b60d3a8a0b3 OK 2025/07/05 05:56:35 INFO : existing: Copied (new) 2025/07/05 05:56:35 DEBUG : Waiting for deletions to finish 2025/07/05 05:56:41 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/07/05 05:56:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:56:46 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/07/05 05:56:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:56:46 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': not deleting files as there were IO errors 2025/07/05 05:56:46 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': not deleting directories as there were IO errors --- PASS: TestSyncImmutable (21.39s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:56:56 DEBUG : EXISTING: md5 = b38e62442425053d8c9d19370264e8c1 OK 2025/07/05 05:57:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 05:57:02 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 05:57:02 DEBUG : existing: Unchanged skipping 2025/07/05 05:57:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 05:57:02 DEBUG : Waiting for deletions to finish 2025/07/05 05:57:02 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (21.13s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:2665: 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-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:2704: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:2704: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" sync_test.go:2704: This test only runs on local --- PASS: TestMaxTransfer (0.60s) --- SKIP: TestMaxTransfer/Hard (0.28s) --- SKIP: TestMaxTransfer/Soft (0.12s) --- SKIP: TestMaxTransfer/Cautious (0.20s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 05:57:18 DEBUG : both0: md5 = 1b563c21c2c233cbf16674454ed78f08 OK 2025/07/05 05:57:23 DEBUG : only0: md5 = 86f359b810c66c3fb6df7066a4f41a64 OK 2025/07/05 05:57:29 DEBUG : both1: md5 = 1936a7e1d36a2e5c5e87f4ee3a83fe8c OK 2025/07/05 05:57:34 DEBUG : only1: md5 = 433c04a214e6c1892b11e1a8dcf9b4aa OK 2025/07/05 05:57:35 DEBUG : both2: md5 = 79380b0cde5ad05856ca9f95a9a268ce OK 2025/07/05 05:57:40 DEBUG : only2: md5 = 239f4d151bfaacc5add47c1ddeb39fe1 OK 2025/07/05 05:57:46 DEBUG : both3: md5 = 5f219cb5fe2c947bee0a606184c0a0a0 OK 2025/07/05 05:57:51 DEBUG : only3: md5 = 21e27e41df72d699ef226126ff0ef3b2 OK 2025/07/05 05:57:51 DEBUG : both4: md5 = ae2cc87646bbc25e641e8eab43b00b71 OK 2025/07/05 05:57:52 DEBUG : only4: md5 = 1d7b5b0781b44b98f58d0eae56767258 OK 2025/07/05 05:57:52 DEBUG : both5: md5 = 62ce4fe55147d9328ca4fe4738f68e51 OK 2025/07/05 05:57:53 DEBUG : only5: md5 = 0d0d97251929d4c8c5edd99f08c865ca OK 2025/07/05 05:57:58 DEBUG : both6: md5 = f4b3bff7a1dadc3909ad609a7db0ec1d OK 2025/07/05 05:58:03 DEBUG : only6: md5 = 164d53946766eee7e8afee0bd9ba1f86 OK 2025/07/05 05:58:04 DEBUG : both7: md5 = 954794aaf588c2f717c83b8654678e2c OK 2025/07/05 05:58:04 DEBUG : only7: md5 = 4d5b650006f419c91cd6b10878279cc4 OK 2025/07/05 05:58:09 DEBUG : both8: md5 = edcc5a7deb845f9bf55f6745c8dcfd9a OK 2025/07/05 05:58:15 DEBUG : only8: md5 = 9f18f94973ac9475e375af8cfff28c3f OK 2025/07/05 05:58:20 DEBUG : both9: md5 = ff7b37568e7afb248bfd545f9b87088c OK 2025/07/05 05:58:25 DEBUG : only9: md5 = 1afd15700524f3a0d5ab9b0cce5518eb OK 2025/07/05 05:58:25 DEBUG : both10: md5 = c71b69dffc6f1a3b26a0453af9deb9f0 OK 2025/07/05 05:58:31 DEBUG : only10: md5 = 397fdf339b55b54c7f1ca104be71a3d6 OK 2025/07/05 05:58:31 DEBUG : both11: md5 = db950342ddbba4962474b0d8906849dc OK 2025/07/05 05:58:31 DEBUG : only11: md5 = ac9a453f54d8d6f133733b3b2f837d60 OK 2025/07/05 05:58:32 DEBUG : both12: md5 = edc4ed00ad5c3fabeefaf890e614e99e OK 2025/07/05 05:58:37 DEBUG : only12: md5 = 7d342c809cf638f6d7f8c10d5fd019bd OK 2025/07/05 05:58:42 DEBUG : both13: md5 = a1a8ead67fe63f4762b838e5f5e311f6 OK 2025/07/05 05:58:43 DEBUG : only13: md5 = 8dfe5f004bd31b594c36823d1173d915 OK 2025/07/05 05:58:43 DEBUG : both14: md5 = 4545032ceabbac9d4d58964f5cba942e OK 2025/07/05 05:58:43 DEBUG : only14: md5 = ff0c1f86600a7de7f6575b5a3ea5f8d7 OK 2025/07/05 05:58:44 DEBUG : both15: md5 = 2cdc72325cd3088231c5287f0bfa9b3e OK 2025/07/05 05:58:44 DEBUG : only15: md5 = 5fd1e2c27a92baced7a629f3385729d6 OK 2025/07/05 05:58:49 DEBUG : both16: md5 = fb274c2a2dd312f31059f7d2b912c42b OK 2025/07/05 05:58:55 DEBUG : only16: md5 = 06ed470190672b0e4b37c21b5153a274 OK 2025/07/05 05:59:00 DEBUG : both17: md5 = b780198cd7c1f369bf390896139a9842 OK 2025/07/05 05:59:01 DEBUG : only17: md5 = 8a530de621cb4bdf040cd22741e9eb88 OK 2025/07/05 05:59:02 DEBUG : both18: md5 = ab111885b01109425fc28d653b059e87 OK 2025/07/05 05:59:02 DEBUG : only18: md5 = d6ac444ed1071d75c49c1518762c313e OK 2025/07/05 05:59:08 DEBUG : both19: md5 = db0512af6a5dd44e9baa58a89de5f0b0 OK 2025/07/05 05:59:13 DEBUG : only19: md5 = 277f38cdf8fa8c7599b546ed62b37358 OK 2025/07/05 06:00:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 06:00:00 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both0: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both10: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both11: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both12: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both14: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both13: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both15: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both16: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both17: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both18: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both2: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both4: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both5: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both6: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both7: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both8: Unchanged skipping 2025/07/05 06:00:00 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:00 DEBUG : both9: Unchanged skipping 2025/07/05 06:00:05 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:05 DEBUG : both19: Unchanged skipping 2025/07/05 06:00:05 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:05 DEBUG : both1: Unchanged skipping 2025/07/05 06:00:05 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:00:05 DEBUG : both3: Unchanged skipping 2025/07/05 06:00:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 06:00:05 DEBUG : Waiting for deletions to finish 2025/07/05 06:00:05 INFO : only11: Deleted 2025/07/05 06:00:05 INFO : only18: Deleted 2025/07/05 06:00:05 INFO : only4: Deleted 2025/07/05 06:00:06 INFO : only7: Deleted 2025/07/05 06:00:06 INFO : only14: Deleted 2025/07/05 06:00:11 INFO : only6: Deleted 2025/07/05 06:00:11 INFO : only8: Deleted 2025/07/05 06:00:11 INFO : only13: Deleted 2025/07/05 06:00:11 INFO : only15: Deleted 2025/07/05 06:00:12 INFO : only17: Deleted 2025/07/05 06:00:15 INFO : only3: Deleted 2025/07/05 06:00:16 INFO : only0: Deleted 2025/07/05 06:00:16 INFO : only19: Deleted 2025/07/05 06:00:17 INFO : only1: Deleted 2025/07/05 06:00:20 INFO : only2: Deleted 2025/07/05 06:00:26 INFO : only16: Deleted 2025/07/05 06:00:26 INFO : only9: Deleted 2025/07/05 06:00:26 INFO : only5: Deleted 2025/07/05 06:00:26 INFO : only10: Deleted 2025/07/05 06:00:27 INFO : only12: Deleted 2025/07/05 06:00:27 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (278.08s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 06:01:56 DEBUG : both0: md5 = 119b3c59faebeb39105205980c6fd741 OK 2025/07/05 06:02:01 DEBUG : only0: md5 = 2f1cc0369b7aacd314f5a196ec10c9b7 OK 2025/07/05 06:02:06 DEBUG : both1: md5 = f3c92d615ee90ceae13eda6830ee749f OK 2025/07/05 06:02:12 DEBUG : only1: md5 = 00c2b4d552e189b8f02463d0f4ebd641 OK 2025/07/05 06:02:12 DEBUG : both2: md5 = b44d8c82477cde6006242d998df7e752 OK 2025/07/05 06:02:17 DEBUG : only2: md5 = 7f3429f11e2f5ffbd3cddb7682f51a61 OK 2025/07/05 06:02:22 DEBUG : both3: md5 = ada62beb1b24137fc368444fb734830e OK 2025/07/05 06:02:27 DEBUG : only3: md5 = 1ee433278315bf82abee65ddd492784c OK 2025/07/05 06:02:28 DEBUG : both4: md5 = 79656d44891b94d2c4f08f15de2a6e26 OK 2025/07/05 06:02:28 DEBUG : only4: md5 = 7073841b4e9089f88c20df250b7169fa OK 2025/07/05 06:02:28 DEBUG : both5: md5 = e041235fbe530ad0c68b0080c3a5ad61 OK 2025/07/05 06:02:28 DEBUG : only5: md5 = 05fd3ef1913a5a440e97708727bcd37c OK 2025/07/05 06:02:33 DEBUG : both6: md5 = d982f21e65be5f5fd4bed3fef3c5c847 OK 2025/07/05 06:02:39 DEBUG : only6: md5 = 589e0288690a8e01c20d7dab7203e68a OK 2025/07/05 06:02:39 DEBUG : both7: md5 = 6a8adc73f74208649bb33002a4919c6e OK 2025/07/05 06:02:39 DEBUG : only7: md5 = bcb137f1f39121318cb612905fdb97c1 OK 2025/07/05 06:02:44 DEBUG : both8: md5 = 02448ff29c249c528681a60604748e4e OK 2025/07/05 06:02:49 DEBUG : only8: md5 = 5b16714153dcc66a7ade15494cd3cfcc OK 2025/07/05 06:02:54 DEBUG : both9: md5 = 039ab6a9d2da39782743f2536f2c19be OK 2025/07/05 06:02:59 DEBUG : only9: md5 = a60ac272b3539211b3b32b0891442af8 OK 2025/07/05 06:03:00 DEBUG : both10: md5 = ba388d1046839ff474813dd0cd56173e OK 2025/07/05 06:03:05 DEBUG : only10: md5 = 18e56e990aa361975fa85ca3b6db46d4 OK 2025/07/05 06:03:05 DEBUG : both11: md5 = 726aa040df8e8fffd49632d621b15947 OK 2025/07/05 06:03:05 DEBUG : only11: md5 = 44a5eb3b5f5ed55afa88df09031a56ab OK 2025/07/05 06:03:05 DEBUG : both12: md5 = 9c72eeeff7b78fa6e3c0c5d47ce64c6e OK 2025/07/05 06:03:10 DEBUG : only12: md5 = 39cc9d9962274ab2d75523df4603d33c OK 2025/07/05 06:03:15 DEBUG : both13: md5 = 5fefd1858acef2f6dcda7477f619514d OK 2025/07/05 06:03:16 DEBUG : only13: md5 = 3b38cc21afb06b23e546b83e5af0022d OK 2025/07/05 06:03:16 DEBUG : both14: md5 = bad6038020a151e4761be095a1aef841 OK 2025/07/05 06:03:16 DEBUG : only14: md5 = 542ac6d6b2107e7c07c0e6e93491b805 OK 2025/07/05 06:03:16 DEBUG : both15: md5 = 45d6d7460b8aedbc047b2223a13d7942 OK 2025/07/05 06:03:16 DEBUG : only15: md5 = 699ca923c4a502ef9fd30989d99b2a82 OK 2025/07/05 06:03:22 DEBUG : both16: md5 = d109c6341dcb1b24819e032b0e069663 OK 2025/07/05 06:03:27 DEBUG : only16: md5 = 0be50ec5067e1ba15b64f414429361ed OK 2025/07/05 06:03:32 DEBUG : both17: md5 = 240bdd5f59a4824a8dbcf84724faee5a OK 2025/07/05 06:03:32 DEBUG : only17: md5 = 2f6be4e9aad48d17ff21a7672d4b7b24 OK 2025/07/05 06:03:32 DEBUG : both18: md5 = 16d3bf46d023121d3197712b7412e8d6 OK 2025/07/05 06:03:33 DEBUG : only18: md5 = 80dea6470a9345a76141d20ade6ea007 OK 2025/07/05 06:03:38 DEBUG : both19: md5 = 649cd7692bf353c7e306c389f039bbaf OK 2025/07/05 06:03:43 DEBUG : only19: md5 = 130ef7b53e4830e0799b5b7d0a257e9a OK 2025/07/05 06:04:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 06:04:20 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:20 DEBUG : both11: Unchanged skipping 2025/07/05 06:04:20 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:20 DEBUG : both10: Unchanged skipping 2025/07/05 06:04:20 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:20 DEBUG : both12: Unchanged skipping 2025/07/05 06:04:21 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:21 DEBUG : both14: Unchanged skipping 2025/07/05 06:04:21 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:21 DEBUG : both15: Unchanged skipping 2025/07/05 06:04:25 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:25 DEBUG : both0: Unchanged skipping 2025/07/05 06:04:25 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:25 DEBUG : both18: Unchanged skipping 2025/07/05 06:04:25 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:25 DEBUG : both19: Unchanged skipping 2025/07/05 06:04:25 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:25 DEBUG : both1: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both13: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both2: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both3: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both16: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both4: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both17: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both5: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both6: Unchanged skipping 2025/07/05 06:04:26 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/07/05 06:04:26 DEBUG : both7: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both8: Unchanged skipping 2025/07/05 06:04:26 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:04:26 DEBUG : both9: Unchanged skipping 2025/07/05 06:04:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 06:04:26 DEBUG : only11: md5 = e34ecb7c8f1ac5c39bff3d460b9d9539 OK 2025/07/05 06:04:26 INFO : only11: Copied (replaced existing) 2025/07/05 06:04:26 DEBUG : only13: md5 = d8bf06cb78f126ca6d4486094e9dcd17 OK 2025/07/05 06:04:26 INFO : only13: Copied (replaced existing) 2025/07/05 06:04:26 DEBUG : only14: md5 = d155d3fc8dc824d8184bd9a149631a14 OK 2025/07/05 06:04:26 INFO : only14: Copied (replaced existing) 2025/07/05 06:04:27 DEBUG : only15: md5 = 7ced9aabb35c708ee22c43142450cb45 OK 2025/07/05 06:04:27 INFO : only15: Copied (replaced existing) 2025/07/05 06:04:31 DEBUG : only12: md5 = cd3f31044002742dbefb3c4597ac032c OK 2025/07/05 06:04:31 INFO : only12: Copied (replaced existing) 2025/07/05 06:04:31 DEBUG : only10: md5 = 055a059fd235e2a9ecaac8b5242d5539 OK 2025/07/05 06:04:31 INFO : only10: Copied (replaced existing) 2025/07/05 06:04:31 DEBUG : only17: md5 = 27b50a26a620fa059833fe5bb4e3017e OK 2025/07/05 06:04:31 INFO : only17: Copied (replaced existing) 2025/07/05 06:04:31 DEBUG : only18: md5 = 8919f9f4c7e15aa232bb1a1394e3c55f OK 2025/07/05 06:04:31 INFO : only18: Copied (replaced existing) 2025/07/05 06:04:32 DEBUG : only16: md5 = cae4501d2f849376473e5de0206e30e2 OK 2025/07/05 06:04:32 INFO : only16: Copied (replaced existing) 2025/07/05 06:04:36 DEBUG : only0: md5 = b705c32b0c057f4f5cefb3d2dc12f6aa OK 2025/07/05 06:04:36 INFO : only0: Copied (replaced existing) 2025/07/05 06:04:37 DEBUG : only1: md5 = ba0f060a8d5e96a9527a42537bc3d9d3 OK 2025/07/05 06:04:37 INFO : only1: Copied (replaced existing) 2025/07/05 06:04:37 DEBUG : only2: md5 = 0a7a8297bfb0aad2cec7d20946722e12 OK 2025/07/05 06:04:37 INFO : only2: Copied (replaced existing) 2025/07/05 06:04:37 DEBUG : only4: md5 = 3a7e300808dca5dde4ef14db3f7a1f47 OK 2025/07/05 06:04:37 INFO : only4: Copied (replaced existing) 2025/07/05 06:04:37 DEBUG : only5: md5 = c885cf073ae6da3e12495ea598963de3 OK 2025/07/05 06:04:37 INFO : only5: Copied (replaced existing) 2025/07/05 06:04:38 DEBUG : only7: md5 = 3aec21c0304058b9c4b20d3c0da287be OK 2025/07/05 06:04:38 INFO : only7: Copied (replaced existing) 2025/07/05 06:04:41 DEBUG : only3: md5 = 4fa0176238594bff8df3aa341a94ab45 OK 2025/07/05 06:04:41 INFO : only3: Copied (replaced existing) 2025/07/05 06:04:41 DEBUG : only19: md5 = b811933590d309dee0f27fa93d8f85aa OK 2025/07/05 06:04:41 INFO : only19: Copied (replaced existing) 2025/07/05 06:04:43 DEBUG : only8: md5 = ce27c1941ca50e8b8f509a3874062b16 OK 2025/07/05 06:04:43 INFO : only8: Copied (replaced existing) 2025/07/05 06:04:46 DEBUG : only9: md5 = fb354c4610c0f56267634e7c01e58fe2 OK 2025/07/05 06:04:46 INFO : only9: Copied (replaced existing) 2025/07/05 06:04:47 DEBUG : only6: md5 = 60848a8c22b10778f808c567ca8744ac OK 2025/07/05 06:04:47 INFO : only6: Copied (replaced existing) 2025/07/05 06:04:47 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (359.32s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 06:07:50 DEBUG : empty_dir: Making directory with metadata 2025/07/05 06:07:50 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 06:07:50 DEBUG : empty_on_remote: Making directory with metadata 2025/07/05 06:07:50 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 06:07:50 INFO : empty_on_remote: Making directory 2025/07/05 06:07:50 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2025/07/05 06:07:56 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/07/05 06:07:56 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/07/05 06:07:56 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/07/05 06:07:56 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) --- PASS: TestSyncReplaceDirModTime (26.40s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 06:08:17 DEBUG : empty_dir: Making directory with metadata 2025/07/05 06:08:17 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 06:08:17 DEBUG : empty_on_remote: Making directory with metadata 2025/07/05 06:08:17 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/07/05 06:08:17 INFO : empty_on_remote: Making directory 2025/07/05 06:08:17 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2025/07/05 06:08:22 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/07/05 06:08:22 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/07/05 06:08:22 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/07/05 06:08:22 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/07/05 06:08:22 INFO : empty_dir: Set directory modification time (using DirSetModTime) --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (26.70s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 06:08:43 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/07/05 06:08:43 INFO : sub dir: Making directory 2025/07/05 06:08:43 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC --- PASS: TestNothingToTransferWithEmptyDirs (22.26s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 06:09:06 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/07/05 06:09:06 INFO : sub dir: Making directory 2025/07/05 06:09:06 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC --- PASS: TestNothingToTransferWithoutEmptyDirs (32.29s) === RUN TestTransform === RUN TestTransform/NFC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 06:09:43 DEBUG : dir1/0000-abcdefg.txt: md5 = ad9775011883e2a616b0f70d01c12d2b OK 2025/07/05 06:09:49 DEBUG : dir1/0001-bcdefgh.txt: md5 = f48d712642e36b874b425425cba23a61 OK 2025/07/05 06:09:54 DEBUG : dir1/0002-cdefghi.txt: md5 = 7a8b3a0db300132d93f1aec3561116f8 OK 2025/07/05 06:09:55 DEBUG : dir1/0003-defghij.txt: md5 = 3d32fb926f2a11a383425ae32041a04f OK 2025/07/05 06:10:01 DEBUG : dir1/0004-efghijk.txt: md5 = 93473a70b6e61f094aae4e315c2107d8 OK 2025/07/05 06:10:06 DEBUG : dir1/0005-fghijkl.txt: md5 = d997077c30626a3897c15871356777fe OK 2025/07/05 06:10:07 DEBUG : dir1/0006-ghijklm.txt: md5 = 8047a369e419ed6a727cbf24927504f0 OK 2025/07/05 06:10:12 DEBUG : dir1/0007-1234567.txt: md5 = ebe55d6f9a39e141390a70a8a05e548d OK 2025/07/05 06:10:18 DEBUG : dir1/0008-2345678.txt: md5 = fc0884c31c7e9c028c13618416213034 OK 2025/07/05 06:10:18 DEBUG : dir1/0009-3456789.txt: md5 = 093fdbb4517010c5453acfd4dbf188b0 OK 2025/07/05 06:10:23 DEBUG : dir1/0010-456789.txt: md5 = 7d74d7391c8faef37e830de4850106a4 OK 2025/07/05 06:10:24 DEBUG : dir1/0011-56789;.txt: md5 = 83b618f468e09228688897679a3699cb OK 2025/07/05 06:10:24 DEBUG : dir1/0012-6789;.txt: md5 = 800b40b4732d4bcbbe8b628f7f4472b7 OK 2025/07/05 06:10:24 DEBUG : dir1/0013-789;=.txt: md5 = 8e97b012206abd8ec28aca9d05bbc4e6 OK 2025/07/05 06:10:25 DEBUG : dir1/0014-89;=.txt: md5 = 1de33fa432db8a98591521795a86881f OK 2025/07/05 06:10:30 DEBUG : dir1/0015-9;=.txt: md5 = e1d659ab7c9e93e19477c5fcc7089cc7 OK 2025/07/05 06:10:35 DEBUG : apple: md5 = e050bfa5d4269e364dbc061aaa195300 OK 2025/07/05 06:10:36 DEBUG : banana: md5 = 5becdd3abb705d916116bf45401969d9 OK 2025/07/05 06:10:41 DEBUG : appleappleapplebanana: md5 = 04f5031c542bd5c8812227df463e2971 OK 2025/07/05 06:10:41 DEBUG : splitbananasplit: md5 = cacad98824a0d254c16cd5a62f031f24 OK 2025/07/05 06:10:41 DEBUG : Waiting for deletions to finish 2025/07/05 06:10:41 DEBUG : apple: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : banana: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/07/05 06:10:41 DEBUG : splitbananasplit: Excluded (Path Filter) 2025/07/05 06:11:13 DEBUG : apple: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : apple: Unchanged skipping 2025/07/05 06:11:13 DEBUG : appleappleapplebanana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : appleappleapplebanana: Unchanged skipping 2025/07/05 06:11:13 DEBUG : splitbananasplit: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : splitbananasplit: Unchanged skipping 2025/07/05 06:11:13 DEBUG : banana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : banana: Unchanged skipping 2025/07/05 06:11:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 06:11:13 DEBUG : dir1/0003-defghij.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0003-defghij.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0001-bcdefgh.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0001-bcdefgh.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0002-cdefghi.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0002-cdefghi.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0005-fghijkl.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0005-fghijkl.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0007-1234567.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0007-1234567.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0006-ghijklm.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0006-ghijklm.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0009-3456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0009-3456789.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0011-56789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0011-56789;.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0012-6789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0012-6789;.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0013-789;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0013-789;=.txt: Unchanged skipping 2025/07/05 06:11:13 DEBUG : dir1/0014-89;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:13 DEBUG : dir1/0014-89;=.txt: Unchanged skipping 2025/07/05 06:11:18 DEBUG : dir1/0000-abcdefg.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:18 DEBUG : dir1/0000-abcdefg.txt: Unchanged skipping 2025/07/05 06:11:18 DEBUG : dir1/0004-efghijk.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:18 DEBUG : dir1/0004-efghijk.txt: Unchanged skipping 2025/07/05 06:11:18 DEBUG : dir1/0008-2345678.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:18 DEBUG : dir1/0008-2345678.txt: Unchanged skipping 2025/07/05 06:11:18 DEBUG : dir1/0010-456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:18 DEBUG : dir1/0010-456789.txt: Unchanged skipping 2025/07/05 06:11:18 DEBUG : dir1/0015-9;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:18 DEBUG : dir1/0015-9;=.txt: Unchanged skipping 2025/07/05 06:11:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 06:11:18 DEBUG : Waiting for deletions to finish 2025/07/05 06:11:18 INFO : There was nothing to transfer 2025/07/05 06:11:18 DEBUG : Waiting for deletions to finish 2025/07/05 06:11:18 DEBUG : apple: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : banana: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/07/05 06:11:18 DEBUG : splitbananasplit: Excluded (Path Filter) 2025/07/05 06:11:19 DEBUG : banana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : banana: Unchanged skipping 2025/07/05 06:11:19 DEBUG : splitbananasplit: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : splitbananasplit: Unchanged skipping 2025/07/05 06:11:19 DEBUG : apple: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : apple: Unchanged skipping 2025/07/05 06:11:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 06:11:19 DEBUG : dir1/0005-fghijkl.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0005-fghijkl.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0002-cdefghi.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0002-cdefghi.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0006-ghijklm.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0006-ghijklm.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0004-efghijk.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0004-efghijk.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0000-abcdefg.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0000-abcdefg.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0003-defghij.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0003-defghij.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0007-1234567.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0007-1234567.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0009-3456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0009-3456789.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0010-456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0010-456789.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0012-6789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0012-6789;.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0008-2345678.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0008-2345678.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0011-56789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0011-56789;.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0015-9;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0015-9;=.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0013-789;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0013-789;=.txt: Unchanged skipping 2025/07/05 06:11:19 DEBUG : dir1/0014-89;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:19 DEBUG : dir1/0014-89;=.txt: Unchanged skipping 2025/07/05 06:11:24 DEBUG : appleappleapplebanana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:24 DEBUG : appleappleapplebanana: Unchanged skipping 2025/07/05 06:11:24 DEBUG : dir1/0001-bcdefgh.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:11:24 DEBUG : dir1/0001-bcdefgh.txt: Unchanged skipping 2025/07/05 06:11:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 06:11:24 DEBUG : Waiting for deletions to finish 2025/07/05 06:11:24 INFO : There was nothing to transfer 2025/07/05 06:11:24 DEBUG : Waiting for deletions to finish 2025/07/05 06:11:24 DEBUG : apple: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : banana: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/07/05 06:11:24 DEBUG : splitbananasplit: Excluded (Path Filter) === RUN TestTransform/NFD run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa'", Local "Local file system at /tmp/rclone3868557063", Modify Window "1ns" 2025/07/05 06:12:43 DEBUG : dir1/0000-abcdefg.txt: md5 = a1cd5f2ae7b51a0e48dd9cb71eba240a OK 2025/07/05 06:12:48 DEBUG : dir1/0001-bcdefgh.txt: md5 = 63cfc08fcdc4d1ec4c7fed6640a78288 OK 2025/07/05 06:12:53 DEBUG : dir1/0002-cdefghi.txt: md5 = ab18d6d3fdffaef4686470dc10d022e8 OK 2025/07/05 06:12:53 DEBUG : dir1/0003-defghij.txt: md5 = 404078e2fa1f23c1da1d364240483960 OK 2025/07/05 06:12:59 DEBUG : dir1/0004-efghijk.txt: md5 = 5c559d075e5e98a6ff0ee4171f4c9ae8 OK 2025/07/05 06:13:04 DEBUG : dir1/0005-fghijkl.txt: md5 = 7881640a68fc3959f9c1082af7fdebac OK 2025/07/05 06:13:04 DEBUG : dir1/0006-ghijklm.txt: md5 = da98db0712a43f3d400c917eb4670337 OK 2025/07/05 06:13:09 DEBUG : dir1/0007-1234567.txt: md5 = 3380975af766877fde804acd87563634 OK 2025/07/05 06:13:14 DEBUG : dir1/0008-2345678.txt: md5 = a43a10fd8b188a2b23a7cd0cfc2bc837 OK 2025/07/05 06:13:15 DEBUG : dir1/0009-3456789.txt: md5 = 8222ba914503bc6d88fd4ce932b25749 OK 2025/07/05 06:13:20 DEBUG : dir1/0010-456789.txt: md5 = 0d4dff1069f1be8d259f10caa972fe28 OK 2025/07/05 06:13:20 DEBUG : dir1/0011-56789;.txt: md5 = b53161986c56a3da017c2b26463e2553 OK 2025/07/05 06:13:20 DEBUG : dir1/0012-6789;.txt: md5 = d66b8f43c6bcd0d971c9edffb5d03936 OK 2025/07/05 06:13:20 DEBUG : dir1/0013-789;=.txt: md5 = 33203f6772ba672a7af290014e84f65c OK 2025/07/05 06:13:20 DEBUG : dir1/0014-89;=.txt: md5 = 7ae6986335e54ef34ca2a49689ef7f89 OK 2025/07/05 06:13:26 DEBUG : dir1/0015-9;=.txt: md5 = 09ef0a899471199e2ea0d19e147ac8bb OK 2025/07/05 06:13:31 DEBUG : apple: md5 = 8f1d9cd57ff301c28588a973e5236fa4 OK 2025/07/05 06:13:31 DEBUG : banana: md5 = 5707d4ecbc0543faa456e7cd8c08ba50 OK 2025/07/05 06:13:36 DEBUG : appleappleapplebanana: md5 = b2b5072ca977202c12c0571a2c2557a2 OK 2025/07/05 06:13:36 DEBUG : splitbananasplit: md5 = 1d8edac14b14c5d025b0b07df8abd726 OK 2025/07/05 06:13:36 DEBUG : Waiting for deletions to finish 2025/07/05 06:13:36 DEBUG : apple: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : banana: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/07/05 06:13:36 DEBUG : splitbananasplit: Excluded (Path Filter) 2025/07/05 06:13:58 DEBUG : splitbananasplit: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : splitbananasplit: Unchanged skipping 2025/07/05 06:13:58 DEBUG : appleappleapplebanana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : appleappleapplebanana: Unchanged skipping 2025/07/05 06:13:58 DEBUG : apple: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : apple: Unchanged skipping 2025/07/05 06:13:58 DEBUG : banana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : banana: Unchanged skipping 2025/07/05 06:13:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 06:13:58 DEBUG : dir1/0001-bcdefgh.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0001-bcdefgh.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0005-fghijkl.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0005-fghijkl.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0002-cdefghi.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0002-cdefghi.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0000-abcdefg.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0000-abcdefg.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0007-1234567.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0007-1234567.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0003-defghij.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0003-defghij.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0008-2345678.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0008-2345678.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0006-ghijklm.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0006-ghijklm.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0010-456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0010-456789.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0013-789;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0013-789;=.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0011-56789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0011-56789;.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0009-3456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0009-3456789.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0014-89;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0014-89;=.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0012-6789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0012-6789;.txt: Unchanged skipping 2025/07/05 06:13:58 DEBUG : dir1/0015-9;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:13:58 DEBUG : dir1/0015-9;=.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0004-efghijk.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0004-efghijk.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 06:14:03 DEBUG : Waiting for deletions to finish 2025/07/05 06:14:03 INFO : There was nothing to transfer 2025/07/05 06:14:03 DEBUG : Waiting for deletions to finish 2025/07/05 06:14:03 DEBUG : apple: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : banana: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : splitbananasplit: Excluded (Path Filter) 2025/07/05 06:14:03 DEBUG : splitbananasplit: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : splitbananasplit: Unchanged skipping 2025/07/05 06:14:03 DEBUG : apple: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : apple: Unchanged skipping 2025/07/05 06:14:03 DEBUG : banana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : banana: Unchanged skipping 2025/07/05 06:14:03 DEBUG : appleappleapplebanana: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : appleappleapplebanana: Unchanged skipping 2025/07/05 06:14:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for checks to finish 2025/07/05 06:14:03 DEBUG : dir1/0003-defghij.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0003-defghij.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0001-bcdefgh.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0001-bcdefgh.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0006-ghijklm.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0006-ghijklm.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0000-abcdefg.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0000-abcdefg.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0002-cdefghi.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0002-cdefghi.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0008-2345678.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0008-2345678.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0009-3456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0009-3456789.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0011-56789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0011-56789;.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0012-6789;.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0012-6789;.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0013-789;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0013-789;=.txt: Unchanged skipping 2025/07/05 06:14:03 DEBUG : dir1/0014-89;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:03 DEBUG : dir1/0014-89;=.txt: Unchanged skipping 2025/07/05 06:14:08 DEBUG : dir1/0007-1234567.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:08 DEBUG : dir1/0005-fghijkl.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:08 DEBUG : dir1/0007-1234567.txt: Unchanged skipping 2025/07/05 06:14:08 DEBUG : dir1/0005-fghijkl.txt: Unchanged skipping 2025/07/05 06:14:08 DEBUG : dir1/0004-efghijk.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:08 DEBUG : dir1/0004-efghijk.txt: Unchanged skipping 2025/07/05 06:14:08 DEBUG : dir1/0010-456789.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:08 DEBUG : dir1/0010-456789.txt: Unchanged skipping 2025/07/05 06:14:08 DEBUG : dir1/0015-9;=.txt: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/07/05 06:14:08 DEBUG : dir1/0015-9;=.txt: Unchanged skipping 2025/07/05 06:14:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gayeyod2kaxa': Waiting for transfers to finish 2025/07/05 06:14:08 DEBUG : Waiting for deletions to finish 2025/07/05 06:14:08 INFO : There was nothing to transfer 2025/07/05 06:14:08 DEBUG : Waiting for deletions to finish 2025/07/05 06:14:08 DEBUG : apple: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : appleappleapplebanana: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : banana: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0000-abcdefg.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0001-bcdefgh.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0002-cdefghi.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0003-defghij.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0004-efghijk.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0005-fghijkl.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0006-ghijklm.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0007-1234567.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0008-2345678.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0009-3456789.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0010-456789.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0011-56789;.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0012-6789;.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0013-789;=.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0014-89;=.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : dir1/0015-9;=.txt: Excluded (Path Filter) 2025/07/05 06:14:08 DEBUG : splitbananasplit: Excluded (Path Filter) panic: test timed out after 1h0m0s running tests: TestTransform (5m42s) TestTransform/NFD (2m42s) goroutine 15445 [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, 6 minutes]: testing.(*T).Run(0xc001aa81c0, {0x2693393?, 0xc001691ad8?}, 0x27bfa10) /usr/local/go/src/testing/testing.go:1859 +0x431 testing.runTests.func1(0xc001aa81c0) /usr/local/go/src/testing/testing.go:2279 +0x37 testing.tRunner(0xc001aa81c0, 0xc001691c18) /usr/local/go/src/testing/testing.go:1792 +0xf4 testing.runTests(0xc001a825d0, {0x3e79440, 0x6c, 0x6c}, {0xedffaabe8?, 0x3e8f400?, 0x3e8f400?}) /usr/local/go/src/testing/testing.go:2277 +0x4b4 testing.(*M).Run(0xc000558a00) /usr/local/go/src/testing/testing.go:2142 +0x64a github.com/rclone/rclone/fstest.TestMain(0xc000558a00) /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:261 +0xa9 goroutine 20 [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 21 [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 13812 [select]: github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0002eba40, {0x2af2a68, 0xc00098c9b0}) /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 13714 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x117 goroutine 1989 [chan receive, 52 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 2107 /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68 goroutine 13969 [chan receive, 4 minutes]: testing.(*T).Run(0xc00081e1c0, {0x26779d5?, 0x41bb05?}, 0xc000748550) /usr/local/go/src/testing/testing.go:1859 +0x431 github.com/rclone/rclone/fs/sync.TestTransform(0xc00081e1c0) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:95 +0x62a testing.tRunner(0xc00081e1c0, 0x27bfa10) /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 14739 [select]: github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc0004863c0, 0xc000437960, 0xc000d368c0) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115 github.com/ncw/swift/v2.(*Connection).Call(0xc0004863c0, {0x2af2988, 0x3eb29c0}, {0xc001a98000, 0x4f}, {{0xc000b87340, 0x5}, {0xc000b87346, 0x2e}, {0x2678bc8, ...}, ...}) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6 github.com/ncw/swift/v2.(*Connection).storage(0xc0004863c0, {0x2af2988, 0x3eb29c0}, {{0xc000b87340, 0x5}, {0xc000b87346, 0x2e}, {0x2678bc8, 0x4}, 0x0, ...}) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:847 +0x151 github.com/ncw/swift/v2.(*Connection).objectBase(0xc00039ef00?, {0x2af2988?, 0x3eb29c0?}, {0xc000b87340?, 0xc?}, {0xc000b87346, 0x2e}) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2143 +0xf8 github.com/rclone/rclone/backend/swift.(*Object).readMetaData.func1.(*Connection).Object.1() /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2132 +0x85 github.com/ncw/swift/v2.withLORetry(0x0, 0xc000bd5478) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/largeobjects.go:303 +0x9f github.com/ncw/swift/v2.(*Connection).Object(...) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2131 github.com/rclone/rclone/backend/swift.(*Object).readMetaData.func1() /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1334 +0x156 github.com/rclone/rclone/fs.pacerInvoker(0x1, 0xa, 0xc001680008?) /home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32 github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc000565800, 0xc002071bc0, 0xa) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:199 +0x7c github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc000565800, 0xc002071bc0) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:218 +0x93 github.com/rclone/rclone/backend/swift.(*Object).readMetaData(0xc0005655c0, {0x2af2988, 0x3eb29c0}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1333 +0x165 github.com/rclone/rclone/backend/swift.(*Object).hasHeader(0xc0005655c0, {0x2af2988?, 0x3eb29c0?}, {0x26ad55e, 0x15}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1246 +0x30 github.com/rclone/rclone/backend/swift.(*Object).isLargeObject(0xc0005655c0, {0x2af2988, 0x3eb29c0}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1277 +0x48 github.com/rclone/rclone/backend/swift.(*Object).Remove(0xc0005655c0, {0x2af2988, 0x3eb29c0}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1597 +0x96 github.com/rclone/rclone/fstest.newRunIndividual.func1.1.1() /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x24 github.com/rclone/rclone/fstest.retry(0xc0008f88c0, {0xc0006009c0, 0x21}, 0xc000bd5920) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:121 +0xde github.com/rclone/rclone/fstest.newRunIndividual.func1.1({0xc0009c1200?, 0xc0009c1200?, 0x1e018f4?}) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x29a github.com/rclone/rclone/fs/walk.listR.func1({0xc0009c1200, 0x14, 0x20}) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:331 +0x1ca github.com/rclone/rclone/backend/crypt.(*Fs).ListR.func1({0xc0009c1200?, 0xc002077bc0?, 0x5?}) /home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:481 +0x5b github.com/rclone/rclone/fs/list.(*Helper).send(...) /home/rclone/go/src/github.com/rclone/rclone/fs/list/helpers.go:29 github.com/rclone/rclone/fs/list.(*Helper).Flush(0xc000bd5b88) /home/rclone/go/src/github.com/rclone/rclone/fs/list/helpers.go:47 +0x35 github.com/rclone/rclone/backend/swift.(*Fs).ListR(0xc000505880, {0x2af2988, 0x3eb29c0}, {0x0?, 0x2414d20?}, 0xc0003ca5a0) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:881 +0x185 github.com/rclone/rclone/backend/crypt.(*Fs).ListR(0xc001a9a000, {0x2af2988, 0x3eb29c0}, {0x0, 0x0}, 0xc0003a3630) /home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:476 +0x118 github.com/rclone/rclone/fs/walk.listR({0x2af2988, 0x3eb29c0}, {0x2b07040, 0xc001a9a000}, {0x0, 0x0}, 0x1, 0x3, 0xc0003ca4b0, 0xc001a821f8, ...) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:299 +0x292 github.com/rclone/rclone/fs/walk.ListR({0x2af2988, 0x3eb29c0}, {0x2b07040, 0xc001a9a000}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc0003ca4b0) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:163 +0x1d5 github.com/rclone/rclone/fstest.newRunIndividual.func1() /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:150 +0x107 github.com/rclone/rclone/fstest.(*Run).Finalise(0xc0000df5e0) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 +0x1c github.com/rclone/rclone/fs/sync.TestTransform.func1(0xc0008f88c0) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:124 +0x3a5 testing.tRunner(0xc0008f88c0, 0xc000748550) /usr/local/go/src/testing/testing.go:1792 +0xf4 created by testing.(*T).Run in goroutine 13969 /usr/local/go/src/testing/testing.go:1851 +0x413 goroutine 15474 [select]: net/http.(*persistConn).roundTrip(0xc0009fdb00, 0xc0001b9770) /usr/local/go/src/net/http/transport.go:2826 +0x785 net/http.(*Transport).roundTrip(0xc000184b60, 0xc000d368c0) /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(0xc00044c0e0, 0xc000d368c0) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345 net/http.send(0xc000d368c0, {0x2acbec0, 0xc00044c0e0}, {0x458701?, 0x47c06e?, 0x0?}) /usr/local/go/src/net/http/client.go:259 +0x5e2 net/http.(*Client).send(0xc0019e7f20, 0xc000d368c0, {0x0?, 0x2?, 0x0?}) /usr/local/go/src/net/http/client.go:180 +0x91 net/http.(*Client).do(0xc0019e7f20, 0xc000d368c0) /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 14739 /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8 goroutine 15149 [select]: net/http.(*persistConn).writeLoop(0xc0009fdb00) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 15192 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 15148 [IO wait]: internal/poll.runtime_pollWait(0x78df946d05b8, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0001ee400?, 0xc000a24c80?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0001ee400, {0xc000a24c80, 0x1980, 0x1980}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0001ee400, {0xc000a24c80?, 0x1973?, 0xc0005227a0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc000520078, {0xc000a24c80?, 0xc00035d6d0?, 0xd?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0017621b0, {0xc000a24c80?, 0x78df9488cd80?, 0x78dfde5c0a78?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc001a83500, {0xc000a24c80?, 0x1973?, 0xc000b779d0?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc00035d7b8, {0x2acd440, 0xc001a83500}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc00035d508, {0x78df951252d8, 0xc0017621b0}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc00035d508, 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(0xc00035d508, {0xc00066a000, 0x1000, 0xc00036b740?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc0009fdb00, {0xc00066a000?, 0x7f4fc5?, 0x2aca340?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc001eb78c0) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc001eb78c0, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc0009fdb00) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 15192 /usr/local/go/src/net/http/transport.go:1944 +0x174f "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished ERROR in 1h0m11.411661369s (try 2/5): exit status 2: Failed []