"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2024/11/29 03:35:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema" 2024/11/29 03:35:53 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/29 03:35:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema.bin" 2024/11/29 03:35:53 DEBUG : Swift container crypt path rclone-test-voxaleb6gema.bin: Auto set use_segments_container to true 2024/11/29 03:35:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema" 2024/11/29 03:35:54 DEBUG : Swift container crypt path rclone-test-voxaleb6gema: Auto set use_segments_container to true 2024/11/29 03:35:55 DEBUG : Creating backend with remote "/tmp/rclone1727897325" === 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-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:35:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:35:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:35:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:35:55 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.59s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:35:56 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/29 03:35:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:35:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:35:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:35:56 DEBUG : sub dir/hello world: md5 = 9e2c5897663584cc7d252a7f065479a9 OK 2024/11/29 03:35:56 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:35:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (1.32s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.19s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.09s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:35:57 DEBUG : Creating backend with remote "/non-existing" 2024/11/29 03:35:57 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2024/11/29 03:35:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:35:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.23s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:35:58 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:35:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:35:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:35:58 DEBUG : sub dir/hello world: md5 = cf3c60520de2dfdedea467332871a65b OK 2024/11/29 03:35:58 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyNoTraverse (1.12s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:35:59 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Running all checks before starting transfers 2024/11/29 03:35:59 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:35:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:35:59 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Checks finished, now starting transfers 2024/11/29 03:35:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:35:59 DEBUG : sub dir/hello world: md5 = 81dff2390ba75bcbaf13f069fcf5da52 OK 2024/11/29 03:35:59 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyCheckFirst (0.93s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:00 ERROR : Ignoring --no-traverse with sync 2024/11/29 03:36:00 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:00 DEBUG : sub dir/hello world: md5 = 664bd94a0d28eed7dbc80295046bb843 OK 2024/11/29 03:36:00 INFO : sub dir/hello world: Copied (new) 2024/11/29 03:36:00 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncNoTraverse (1.00s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:01 DEBUG : hello world2: Need to transfer - File not found at Destination 2024/11/29 03:36:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:01 DEBUG : hello world2: md5 = f6371d412b0b339ae39311fdd723f048 OK 2024/11/29 03:36:01 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyWithDepth (1.15s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:02 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:36:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:02 DEBUG : potato2: md5 = 98f76a26ba6835540b0a213711029f09 OK 2024/11/29 03:36:02 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (1.28s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:03 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:36:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:03 DEBUG : potato2: md5 = b8bb0f36d6917fd6fa17b07c215935c0 OK 2024/11/29 03:36:03 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (0.89s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:04 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/11/29 03:36:04 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/29 03:36:04 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2024/11/29 03:36:04 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/29 03:36:04 DEBUG : sub dir: Making directory 2024/11/29 03:36:04 DEBUG : sub dir2: Making directory 2024/11/29 03:36:04 DEBUG : sub dir2/sub sub dir2: Making directory 2024/11/29 03:36:04 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:04 DEBUG : sub dir/hello world: md5 = f80ce67b2ed229c29610c55af75ddc5d OK 2024/11/29 03:36:04 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2024/11/29 03:36:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (1.00s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:05 DEBUG : sub dir2: Making directory 2024/11/29 03:36:05 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/11/29 03:36:05 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/29 03:36:05 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:05 DEBUG : sub dir/hello world: md5 = 9b135a2a27a1e63ec342045f72c3021f OK 2024/11/29 03:36:05 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (0.94s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:06 DEBUG : sub dir2: Making directory with metadata 2024/11/29 03:36:06 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/29 03:36:06 DEBUG : sub dir: Making directory 2024/11/29 03:36:06 DEBUG : sub dir2: Making directory 2024/11/29 03:36:06 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:06 DEBUG : sub dir/hello world: md5 = 39f55afdf8055e0b0a072df7934e6bf8 OK 2024/11/29 03:36:06 INFO : sub dir/hello world: Copied (new) 2024/11/29 03:36:06 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2024/11/29 03:36:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2024/11/29 03:36:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.25s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.09s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:07 DEBUG : sub dir2: Making directory 2024/11/29 03:36:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:07 DEBUG : sub dir/hello world: md5 = ddc717d8395d5ae389f39a8ad9b0caa3 OK 2024/11/29 03:36:07 INFO : sub dir/hello world: Copied (new) 2024/11/29 03:36:07 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (0.74s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:08 DEBUG : sub dir2: Making directory with metadata 2024/11/29 03:36:08 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/11/29 03:36:08 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/29 03:36:08 DEBUG : sub dir: Making directory 2024/11/29 03:36:08 DEBUG : sub dir2: Making directory 2024/11/29 03:36:08 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:08 DEBUG : sub dir/hello world: md5 = d374af2806fd84e3a9c20c7759b30b05 OK 2024/11/29 03:36:08 INFO : sub dir/hello world: Copied (new) 2024/11/29 03:36:08 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2024/11/29 03:36:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.06s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.25s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:09 DEBUG : sub dir2: Making directory 2024/11/29 03:36:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:09 DEBUG : sub dir/hello world: md5 = 1f8a1e75a6eb9ce43a85eff66a548669 OK 2024/11/29 03:36:09 INFO : sub dir/hello world: Copied (new) 2024/11/29 03:36:09 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (0.77s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:10 DEBUG : sub dir/hello world: md5 = 3b5ab91157633b9095d8aa5e30d21daf OK 2024/11/29 03:36:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-jugurac4fixo" 2024/11/29 03:36:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jugurac4fixo.bin" 2024/11/29 03:36:11 DEBUG : Swift container crypt path rclone-test-jugurac4fixo.bin: Auto set use_segments_container to true 2024/11/29 03:36:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jugurac4fixo" 2024/11/29 03:36:12 DEBUG : Swift container crypt path rclone-test-jugurac4fixo: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema' -> Encrypted drive 'TestCryptSwift:rclone-test-jugurac4fixo' 2024/11/29 03:36:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jugurac4fixo': Waiting for checks to finish 2024/11/29 03:36:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jugurac4fixo': Waiting for transfers to finish 2024/11/29 03:36:14 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jugurac4fixo': Purge remote 2024/11/29 03:36:14 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:14 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (4.66s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:15 DEBUG : sub dir/hello world: md5 = b103174f2bcfd382c56fad207864e45b OK 2024/11/29 03:36:15 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/29 03:36:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:15 DEBUG : sub dir/hello world: md5 = e0e2fa1d6db634c7a15d202fdc5db392 OK 2024/11/29 03:36:15 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyOverSelf (1.66s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:17 DEBUG : sub dir/hello world: md5 = a28d7a7613b8cd6c5b15ce4ffbf517a8 OK 2024/11/29 03:36:17 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-takimel2jesa" 2024/11/29 03:36:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-takimel2jesa.bin" 2024/11/29 03:36:17 DEBUG : Swift container crypt path rclone-test-takimel2jesa.bin: Auto set use_segments_container to true 2024/11/29 03:36:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-takimel2jesa" 2024/11/29 03:36:19 DEBUG : Swift container crypt path rclone-test-takimel2jesa: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema' -> Encrypted drive 'TestCryptSwift:rclone-test-takimel2jesa' 2024/11/29 03:36:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-takimel2jesa': Waiting for checks to finish 2024/11/29 03:36:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-takimel2jesa': Waiting for transfers to finish 2024/11/29 03:36:20 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:20 DEBUG : sub dir/hello world: md5 = c1b259efab02192961620ccf6e5fe0a7 OK 2024/11/29 03:36:21 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/29 03:36:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-takimel2jesa': Waiting for checks to finish 2024/11/29 03:36:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-takimel2jesa': Waiting for transfers to finish 2024/11/29 03:36:21 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-takimel2jesa': Purge remote 2024/11/29 03:36:21 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:22 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (6.15s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:23 DEBUG : sub dir/hello world: md5 = c7048b65b8be583ff5048adcf54b60bb OK 2024/11/29 03:36:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:23 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/29 03:36:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:23 DEBUG : sub dir/hello world: md5 = a016bf078c9370e8836f0a3bac2a86e1 OK 2024/11/29 03:36:23 INFO : sub dir/hello world: Copied (replaced existing) 2024/11/29 03:36:23 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestMoveOverSelf (1.63s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:24 DEBUG : sub dir/hello world: md5 = ca69f644b4614368583b0bb773614a9f OK 2024/11/29 03:36:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-jemapal4yopi" 2024/11/29 03:36:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jemapal4yopi.bin" 2024/11/29 03:36:25 DEBUG : Swift container crypt path rclone-test-jemapal4yopi.bin: Auto set use_segments_container to true 2024/11/29 03:36:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-jemapal4yopi" 2024/11/29 03:36:26 DEBUG : Swift container crypt path rclone-test-jemapal4yopi: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema' -> Encrypted drive 'TestCryptSwift:rclone-test-jemapal4yopi' 2024/11/29 03:36:27 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jemapal4yopi': Waiting for checks to finish 2024/11/29 03:36:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jemapal4yopi': Waiting for transfers to finish 2024/11/29 03:36:27 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:28 DEBUG : sub dir/hello world: md5 = d94ac227f77c2244bb82e9d3a7d341d4 OK 2024/11/29 03:36:28 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/11/29 03:36:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jemapal4yopi': Waiting for checks to finish 2024/11/29 03:36:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jemapal4yopi': Waiting for transfers to finish 2024/11/29 03:36:28 INFO : sub dir/hello world: Copied (server-side copy) 2024/11/29 03:36:28 INFO : sub dir/hello world: Deleted 2024/11/29 03:36:29 DEBUG : sub dir/hello world: md5 = bdd7cd77767b1a3a4e7a028d02bea0fe OK 2024/11/29 03:36:29 DEBUG : testing file moves 2024/11/29 03:36:29 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2024/11/29 03:36:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jemapal4yopi': Waiting for checks to finish 2024/11/29 03:36:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jemapal4yopi': Waiting for transfers to finish 2024/11/29 03:36:30 INFO : sub dir/hello world: Copied (server-side copy) 2024/11/29 03:36:30 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-jemapal4yopi': Purge remote 2024/11/29 03:36:30 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:30 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (6.69s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:31 DEBUG : sub dir/hello world: md5 = 683ecb0264189bf346c3b38eb5e79557 OK 2024/11/29 03:36:31 ERROR : : error listing: directory not found 2024/11/29 03:36:31 DEBUG : Local file system at /tmp/rclone1727897325: Making directory 2024/11/29 03:36:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyAfterDelete (1.07s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:32 DEBUG : sub dir/hello world: md5 = 3cb7fcfad675820808eddf056736fe52 OK 2024/11/29 03:36:32 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:36:32 DEBUG : Local file system at /tmp/rclone1727897325: Waiting for checks to finish 2024/11/29 03:36:32 DEBUG : Local file system at /tmp/rclone1727897325: Waiting for transfers to finish 2024/11/29 03:36:32 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2024/11/29 03:36:32 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyRedownload (1.30s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:33 DEBUG : check sum: Need to transfer - File not found at Destination 2024/11/29 03:36:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:34 DEBUG : check sum: md5 = 9127a685b7ce1c7bf951fc38bad5d4cc OK 2024/11/29 03:36:34 INFO : check sum: Copied (new) 2024/11/29 03:36:34 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:34 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2024/11/29 03:36:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:34 DEBUG : check sum: Size of src and dst objects identical 2024/11/29 03:36:34 DEBUG : check sum: Unchanged skipping 2024/11/29 03:36:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:34 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:34 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (1.65s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:35 DEBUG : sizeonly: Need to transfer - File not found at Destination 2024/11/29 03:36:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:35 DEBUG : sizeonly: md5 = 774b29b274d0cec76c9776e8a0a386d8 OK 2024/11/29 03:36:35 INFO : sizeonly: Copied (new) 2024/11/29 03:36:35 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:36 DEBUG : sizeonly: Sizes identical 2024/11/29 03:36:36 DEBUG : sizeonly: Unchanged skipping 2024/11/29 03:36:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:36 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:36 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncSizeOnly (1.63s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:36 DEBUG : ignore-size: Need to transfer - File not found at Destination 2024/11/29 03:36:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:37 DEBUG : ignore-size: md5 = 8961727c21d947dd621defa3c22f48e4 OK 2024/11/29 03:36:37 INFO : ignore-size: Copied (new) 2024/11/29 03:36:37 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:37 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:36:37 DEBUG : ignore-size: Unchanged skipping 2024/11/29 03:36:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:37 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:37 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (1.57s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:38 DEBUG : existing: md5 = 3fb3b707b5c04c98e31521112454a468 OK 2024/11/29 03:36:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:39 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:36:39 DEBUG : existing: Unchanged skipping 2024/11/29 03:36:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:39 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:39 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:39 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2024/11/29 03:36:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:39 DEBUG : existing: md5 = 7a347b56bd22ef570c867439cdfbde7e OK 2024/11/29 03:36:39 INFO : existing: Copied (replaced existing) 2024/11/29 03:36:39 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (1.94s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:40 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/29 03:36:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:40 DEBUG : existing: md5 = 9aefe042e40eac34491be1120b117808 OK 2024/11/29 03:36:40 INFO : existing: Copied (new) 2024/11/29 03:36:40 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:41 DEBUG : existing: Destination exists, skipping 2024/11/29 03:36:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:41 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:41 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (1.50s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:42 DEBUG : b/potato: md5 = 8d19b0be49b9a73ef757c1215e83f88f OK 2024/11/29 03:36:42 DEBUG : c/non empty space: md5 = 7a6407dfc5991e95af0a385870b1eee5 OK 2024/11/29 03:36:42 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/11/29 03:36:42 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/29 03:36:43 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:36:43 DEBUG : c/non empty space: Unchanged skipping 2024/11/29 03:36:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:43 DEBUG : a/potato2: md5 = 67cccb15ae76428a09f66dcb05d52afc OK 2024/11/29 03:36:43 INFO : a/potato2: Copied (new) 2024/11/29 03:36:43 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:43 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (2.81s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:45 DEBUG : empty space: md5 = 766701e10b19dfdb6067bdf945bbd842 OK 2024/11/29 03:36:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:46 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2024/11/29 03:36:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:46 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2024/11/29 03:36:46 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:46 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2024/11/29 03:36:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:46 DEBUG : empty space: md5 = 38f33f9cb12dd9408a1e12f71372cacf OK 2024/11/29 03:36:46 INFO : empty space: Copied (replaced existing) 2024/11/29 03:36:46 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (2.60s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:1016: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.18s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:48 DEBUG : foo: md5 = bd1efa8d81f9f05b5969955b931a092f OK 2024/11/29 03:36:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:48 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2024/11/29 03:36:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:48 DEBUG : foo: md5 = f690479f09dab02c4decff9883dedd52 OK 2024/11/29 03:36:48 INFO : foo: Copied (replaced existing) 2024/11/29 03:36:48 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (2.29s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:50 DEBUG : empty space: md5 = 04b73bf2a0aa6dbea47c702ab2651c60 OK 2024/11/29 03:36:50 DEBUG : potato: Need to transfer - File not found at Destination 2024/11/29 03:36:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:50 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:36:50 DEBUG : empty space: Unchanged skipping 2024/11/29 03:36:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:50 DEBUG : potato: md5 = 2eb86b150ad46a3d0753e23eeac975b4 OK 2024/11/29 03:36:50 INFO : potato: Copied (new) 2024/11/29 03:36:50 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (2.31s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:52 DEBUG : potato: md5 = fca376d7e4a917bc1dfcd58cc7d757dc OK 2024/11/29 03:36:52 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2024/11/29 03:36:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:52 DEBUG : potato: md5 = d02fbf30c5d3db7a96a48f36ce2f4818 OK 2024/11/29 03:36:52 INFO : potato: Copied (replaced existing) 2024/11/29 03:36:52 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (1.48s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:53 DEBUG : potato: md5 = 32c3bcdaf137ffb408a4060c6e5a8e1a OK 2024/11/29 03:36:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:54 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2024/11/29 03:36:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:54 DEBUG : potato: md5 = 0f12f3260cda87a940251c9889693952 OK 2024/11/29 03:36:54 INFO : potato: Copied (replaced existing) 2024/11/29 03:36:54 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (1.46s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:55 DEBUG : potato: md5 = ff72aa6695782daea167a0f4507cde19 OK 2024/11/29 03:36:55 DEBUG : empty space: md5 = ae340904cb49023e449e6534b753bbce OK 2024/11/29 03:36:56 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:36:56 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2024/11/29 03:36:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:56 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:36:56 DEBUG : empty space: Unchanged skipping 2024/11/29 03:36:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:56 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:56 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (2.06s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:57 DEBUG : potato: md5 = aa6fad13947092e61cbba5b471328c26 OK 2024/11/29 03:36:57 DEBUG : empty space: md5 = 0acc9381a135fb6ad0f7a38427127565 OK 2024/11/29 03:36:57 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:36:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:36:57 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:36:57 DEBUG : empty space: Unchanged skipping 2024/11/29 03:36:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:36:58 DEBUG : potato2: md5 = 66f851e0b5e5dc7580f826c1721028a5 OK 2024/11/29 03:36:58 INFO : potato2: Copied (new) 2024/11/29 03:36:58 DEBUG : Waiting for deletions to finish 2024/11/29 03:36:58 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.18s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:36:59 DEBUG : b/potato: md5 = 98793d8fee6ea0832ca4b6f03d1a2142 OK 2024/11/29 03:36:59 DEBUG : c/non empty space: md5 = 1142f75c3d37f78d3124f3184b957f92 OK 2024/11/29 03:36:59 DEBUG : d: Making directory 2024/11/29 03:36:59 DEBUG : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2024/11/29 03:37:00 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:00 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:00 DEBUG : c/non empty space: Unchanged skipping 2024/11/29 03:37:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:00 DEBUG : a/potato2: md5 = 41db25c47aacb01b62e83d4a0269d8c6 OK 2024/11/29 03:37:00 INFO : a/potato2: Copied (new) 2024/11/29 03:37:00 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:00 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (2.12s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:01 DEBUG : b/potato: md5 = b88d429ff2bc165f0b428072d5562e7d OK 2024/11/29 03:37:01 DEBUG : c/non empty space: md5 = c4668d90aee72c29e342d07e6d60960a OK 2024/11/29 03:37:01 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/11/29 03:37:02 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:02 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:02 DEBUG : c/non empty space: Unchanged skipping 2024/11/29 03:37:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:02 DEBUG : a/potato2: md5 = 8f2e9616b017cced99abc3586c582f23 OK 2024/11/29 03:37:02 INFO : a/potato2: Copied (new) 2024/11/29 03:37:02 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': not deleting files as there were IO errors 2024/11/29 03:37:02 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (2.16s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:03 DEBUG : potato: md5 = 07a8c4f8a294bf89a64feb6492d8ca10 OK 2024/11/29 03:37:04 DEBUG : empty space: md5 = 5fe69a698821caa5ff817106adf18813 OK 2024/11/29 03:37:04 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:04 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:04 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:04 DEBUG : empty space: Unchanged skipping 2024/11/29 03:37:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:04 INFO : potato: Deleted 2024/11/29 03:37:04 DEBUG : potato2: md5 = 035c780f32890fa6f9934243a3799433 OK 2024/11/29 03:37:04 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (2.21s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:05 DEBUG : potato: md5 = 8af6828cf79c6b885d63f21e6aa15c96 OK 2024/11/29 03:37:06 DEBUG : empty space: md5 = 06f649ea943d0b65fc18d20137ab3c1d OK 2024/11/29 03:37:06 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:06 INFO : potato: Deleted 2024/11/29 03:37:06 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:06 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:06 DEBUG : empty space: Unchanged skipping 2024/11/29 03:37:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:07 DEBUG : potato2: md5 = 7d2650fed7240b09d51f1233f640c484 OK 2024/11/29 03:37:07 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (2.22s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:08 DEBUG : potato: md5 = 46a897e87251ac28ff5b523fcff7da56 OK 2024/11/29 03:37:08 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:08 DEBUG : potato2: md5 = 9f71ee649f80b02bdc38bf789f54edf3 OK 2024/11/29 03:37:08 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (1.78s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:10 DEBUG : potato2: md5 = 9dfd476bd8147ff018b6b5802c84da14 OK 2024/11/29 03:37:12 DEBUG : empty space: md5 = 58b90cd0b7cf406ca499a6da2d18a699 OK 2024/11/29 03:37:12 DEBUG : enormous: Excluded (Size Filter) 2024/11/29 03:37:12 DEBUG : enormous: Excluded 2024/11/29 03:37:12 DEBUG : potato2: Excluded (Size Filter) 2024/11/29 03:37:12 DEBUG : potato2: Excluded 2024/11/29 03:37:12 DEBUG : potato2: Excluded (Size Filter) 2024/11/29 03:37:12 DEBUG : potato2: Excluded 2024/11/29 03:37:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:12 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:12 DEBUG : empty space: Unchanged skipping 2024/11/29 03:37:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:12 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:12 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:12 DEBUG : enormous: Excluded (Size Filter) 2024/11/29 03:37:12 DEBUG : enormous: Excluded 2024/11/29 03:37:12 DEBUG : potato2: Excluded (Size Filter) 2024/11/29 03:37:12 DEBUG : potato2: Excluded 2024/11/29 03:37:12 DEBUG : potato2: Excluded (Size Filter) 2024/11/29 03:37:12 DEBUG : potato2: Excluded 2024/11/29 03:37:12 DEBUG : Local file system at /tmp/rclone1727897325: Waiting for checks to finish 2024/11/29 03:37:12 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:12 DEBUG : empty space: Unchanged skipping 2024/11/29 03:37:12 DEBUG : Local file system at /tmp/rclone1727897325: Waiting for transfers to finish 2024/11/29 03:37:12 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:12 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncWithExclude (3.94s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:13 DEBUG : potato2: md5 = 822eb59b54dbb8e391d40ae88544082b OK 2024/11/29 03:37:14 DEBUG : empty space: md5 = 49948d0922f8e6d033b590a28fec72c7 OK 2024/11/29 03:37:14 DEBUG : enormous: md5 = febd0d012256d333607f18c567722e24 OK 2024/11/29 03:37:14 DEBUG : enormous: Excluded (Size Filter) 2024/11/29 03:37:14 DEBUG : enormous: Excluded 2024/11/29 03:37:14 DEBUG : potato2: Excluded (Size Filter) 2024/11/29 03:37:14 DEBUG : potato2: Excluded 2024/11/29 03:37:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:14 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:14 DEBUG : empty space: Unchanged skipping 2024/11/29 03:37:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:14 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:14 INFO : potato2: Deleted 2024/11/29 03:37:14 INFO : enormous: Deleted 2024/11/29 03:37:14 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:15 DEBUG : Local file system at /tmp/rclone1727897325: Waiting for checks to finish 2024/11/29 03:37:15 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:15 DEBUG : empty space: Unchanged skipping 2024/11/29 03:37:15 DEBUG : Local file system at /tmp/rclone1727897325: Waiting for transfers to finish 2024/11/29 03:37:15 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:15 INFO : enormous: Deleted 2024/11/29 03:37:15 INFO : potato2: Deleted 2024/11/29 03:37:15 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (2.56s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:16 DEBUG : one: md5 = 6b2c84c34e8872e73ab55460734ebdab OK 2024/11/29 03:37:16 DEBUG : two: md5 = e23295a3af0d3547c22091aab4b00ea6 OK 2024/11/29 03:37:17 DEBUG : three: md5 = dd6bc285084a5192604f5570724a1370 OK 2024/11/29 03:37:18 DEBUG : four: md5 = a6011f0bb1d394ba1298e60947f957c4 OK 2024/11/29 03:37:18 DEBUG : five: Need to transfer - File not found at Destination 2024/11/29 03:37:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:18 DEBUG : four: Sizes differ (src 4 vs dst 8) 2024/11/29 03:37:18 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2024/11/29 03:37:18 DEBUG : one: Destination is newer than source, skipping 2024/11/29 03:37:18 DEBUG : three: Sizes identical 2024/11/29 03:37:18 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2024/11/29 03:37:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:18 DEBUG : two: md5 = 842ec962e4bb5cb7b2a838f250159899 OK 2024/11/29 03:37:18 INFO : two: Copied (replaced existing) 2024/11/29 03:37:18 DEBUG : four: md5 = 26d3ff5ba62a2f07e7940a8164473d41 OK 2024/11/29 03:37:18 INFO : four: Copied (replaced existing) 2024/11/29 03:37:19 DEBUG : five: md5 = 896968f22a90e48bcd7be710b64bb4f3 OK 2024/11/29 03:37:19 INFO : five: Copied (new) 2024/11/29 03:37:19 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (4.20s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1466: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1466: Skipping test on non local remote --- PASS: TestSyncWithMaxDuration (0.00s) --- SKIP: TestSyncWithMaxDuration/Hard (0.00s) --- SKIP: TestSyncWithMaxDuration/Soft (0.00s) === RUN TestSyncWithTrackRenames run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2024/11/29 03:37:20 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Ignoring --track-renames as the source and destination do not have a common hash 2024/11/29 03:37:20 DEBUG : potato: Need to transfer - File not found at Destination 2024/11/29 03:37:20 DEBUG : yam: Need to transfer - File not found at Destination 2024/11/29 03:37:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:20 DEBUG : potato: md5 = d59801656c424af042ce6164917927a5 OK 2024/11/29 03:37:20 INFO : potato: Copied (new) 2024/11/29 03:37:21 DEBUG : yam: md5 = a4aa2e0adbca8c0660d5376a2565d413 OK 2024/11/29 03:37:21 INFO : yam: Copied (new) 2024/11/29 03:37:21 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:21 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Ignoring --track-renames as the source and destination do not have a common hash 2024/11/29 03:37:21 DEBUG : yaml: Need to transfer - File not found at Destination 2024/11/29 03:37:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:21 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:21 DEBUG : potato: Unchanged skipping 2024/11/29 03:37:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:22 DEBUG : yaml: md5 = a54932c4beaed915bc6de4f861ab8bd4 OK 2024/11/29 03:37:22 INFO : yaml: Copied (new) 2024/11/29 03:37:22 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:22 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (3.04s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2024/11/29 03:37:23 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Making map for --track-renames 2024/11/29 03:37:23 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Finished making map for --track-renames 2024/11/29 03:37:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:23 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/29 03:37:23 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/11/29 03:37:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for renames to finish 2024/11/29 03:37:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:23 DEBUG : potato: md5 = 29993a650b7ef7079a3573e8be48fccb OK 2024/11/29 03:37:23 INFO : potato: Copied (new) 2024/11/29 03:37:23 DEBUG : yam: md5 = 513869cdecc2deb3de5adb2d00f5344e OK 2024/11/29 03:37:23 INFO : yam: Copied (new) 2024/11/29 03:37:23 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:24 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Making map for --track-renames 2024/11/29 03:37:24 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Finished making map for --track-renames 2024/11/29 03:37:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:24 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:24 DEBUG : potato: Unchanged skipping 2024/11/29 03:37:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for renames to finish 2024/11/29 03:37:24 INFO : yam: Copied (server-side copy) to: yaml 2024/11/29 03:37:24 INFO : yam: Deleted 2024/11/29 03:37:24 INFO : yaml: Renamed from "yam" 2024/11/29 03:37:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:24 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (2.54s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2024/11/29 03:37:26 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Making map for --track-renames 2024/11/29 03:37:26 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Finished making map for --track-renames 2024/11/29 03:37:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:26 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/11/29 03:37:26 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/11/29 03:37:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for renames to finish 2024/11/29 03:37:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:26 DEBUG : potato: md5 = 7cf9f35a4e561acd8f72da535292c8fd OK 2024/11/29 03:37:26 INFO : potato: Copied (new) 2024/11/29 03:37:26 DEBUG : sub/yam: md5 = 24c26630b44a4a085da5bf8ef4445785 OK 2024/11/29 03:37:26 INFO : sub/yam: Copied (new) 2024/11/29 03:37:26 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:27 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:27 DEBUG : potato: Unchanged skipping 2024/11/29 03:37:27 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Making map for --track-renames 2024/11/29 03:37:27 INFO : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Finished making map for --track-renames 2024/11/29 03:37:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for renames to finish 2024/11/29 03:37:27 INFO : sub/yam: Copied (server-side copy) to: yam 2024/11/29 03:37:27 INFO : sub/yam: Deleted 2024/11/29 03:37:27 INFO : yam: Renamed from "sub/yam" 2024/11/29 03:37:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:27 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (3.12s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:29 DEBUG : Creating backend with remote "/tmp/rclone1727897325/dir1" 2024/11/29 03:37:29 DEBUG : Config file has changed externally - reloading 2024/11/29 03:37:29 DEBUG : Creating backend with remote "/tmp/rclone1727897325/dir2" 2024/11/29 03:37:29 DEBUG : Local file system at /tmp/rclone1727897325/dir2: Using server-side directory move 2024/11/29 03:37:29 INFO : Local file system at /tmp/rclone1727897325/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/11/29 03:37:29 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/11/29 03:37:29 INFO : file1.txt: Moved (server-side) 2024/11/29 03:37:29 DEBUG : Local file system at /tmp/rclone1727897325/dir2: Waiting for checks to finish 2024/11/29 03:37:29 DEBUG : Local file system at /tmp/rclone1727897325/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.18s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:37:29 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/11/29 03:37:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:29 DEBUG : sub dir/hello world: md5 = 70457768728cb6c35b0991960476d694 OK 2024/11/29 03:37:29 INFO : sub dir/hello world: Copied (new) 2024/11/29 03:37:29 INFO : sub dir/hello world: Deleted 2024/11/29 03:37:29 DEBUG : nested/sub dir/file: md5 = baf8363da42a824813f7049f3bb4c91c OK 2024/11/29 03:37:29 INFO : nested/sub dir/file: Copied (new) 2024/11/29 03:37:29 INFO : nested/sub dir/file: Deleted 2024/11/29 03:37:29 INFO : sub dir: Removing directory 2024/11/29 03:37:29 INFO : nested/sub dir: Removing directory 2024/11/29 03:37:29 INFO : nested: Removing directory 2024/11/29 03:37:29 DEBUG : Local file system at /tmp/rclone1727897325: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (1.39s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/11/29 03:37:30 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/11/29 03:37:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:30 DEBUG : sub dir/hello world: md5 = 4c745fcfc99fa0374ecd6bfdb87da3ad OK 2024/11/29 03:37:30 INFO : sub dir/hello world: Copied (new) 2024/11/29 03:37:30 INFO : sub dir/hello world: Deleted 2024/11/29 03:37:31 DEBUG : nested/sub dir/file: md5 = b2a8f7aa5153963819d29599b94960d0 OK 2024/11/29 03:37:31 INFO : nested/sub dir/file: Copied (new) 2024/11/29 03:37:31 INFO : nested/sub dir/file: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (1.28s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:32 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/29 03:37:32 DEBUG : existing-b: Need to transfer - File not found at Destination 2024/11/29 03:37:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:32 DEBUG : existing: md5 = 1a9d18a91745142a9c4be365f7f98710 OK 2024/11/29 03:37:32 INFO : existing: Copied (new) 2024/11/29 03:37:32 INFO : existing: Deleted 2024/11/29 03:37:32 DEBUG : existing-b: md5 = dfe10ad99f36c80d1c9e81278c7bde45 OK 2024/11/29 03:37:32 INFO : existing-b: Copied (new) 2024/11/29 03:37:32 INFO : existing-b: Deleted 2024/11/29 03:37:33 DEBUG : existing: Destination exists, skipping 2024/11/29 03:37:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:37:33 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2024/11/29 03:37:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:37:33 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (1.85s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:33 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-difigul0fubu" 2024/11/29 03:37:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-difigul0fubu.bin" 2024/11/29 03:37:34 DEBUG : Swift container crypt path rclone-test-difigul0fubu.bin: Auto set use_segments_container to true 2024/11/29 03:37:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-difigul0fubu" 2024/11/29 03:37:35 DEBUG : Swift container crypt path rclone-test-difigul0fubu: Auto set use_segments_container to true 2024/11/29 03:37:36 DEBUG : potato2: md5 = ce744932a639d2a4d0be7ad335dc7163 OK 2024/11/29 03:37:36 DEBUG : empty space: md5 = 7fa95a908ad94f93fe8b7fd684a97313 OK 2024/11/29 03:37:37 DEBUG : potato3: md5 = 5ebac2088733b5a444fba9c3c2b4823f OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema' -> Encrypted drive 'TestCryptSwift:rclone-test-difigul0fubu' 2024/11/29 03:37:38 DEBUG : empty space: md5 = c686dd7a41583dd7494d39de89ac1f04 OK 2024/11/29 03:37:38 DEBUG : potato3: md5 = df91a8fba234adc5936ebfe61fef958f OK 2024/11/29 03:37:39 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:39 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/29 03:37:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-difigul0fubu': Waiting for checks to finish 2024/11/29 03:37:39 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:39 DEBUG : empty space: Unchanged skipping 2024/11/29 03:37:39 INFO : potato2: Copied (server-side copy) 2024/11/29 03:37:39 INFO : potato2: Deleted 2024/11/29 03:37:39 INFO : empty space: Deleted 2024/11/29 03:37:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-difigul0fubu': Waiting for transfers to finish 2024/11/29 03:37:39 INFO : potato3: Copied (server-side copy) 2024/11/29 03:37:39 INFO : potato3: Deleted 2024/11/29 03:37:40 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qadamut2hela" 2024/11/29 03:37:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qadamut2hela.bin" 2024/11/29 03:37:40 DEBUG : Swift container crypt path rclone-test-qadamut2hela.bin: Auto set use_segments_container to true 2024/11/29 03:37:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qadamut2hela" 2024/11/29 03:37:41 DEBUG : Swift container crypt path rclone-test-qadamut2hela: Auto set use_segments_container to true 2024/11/29 03:37:42 DEBUG : empty space: Need to transfer - File not found at Destination 2024/11/29 03:37:42 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:42 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/29 03:37:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qadamut2hela': Waiting for checks to finish 2024/11/29 03:37:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qadamut2hela': Waiting for transfers to finish 2024/11/29 03:37:43 INFO : potato3: Copied (server-side copy) 2024/11/29 03:37:43 INFO : empty space: Copied (server-side copy) 2024/11/29 03:37:43 INFO : potato2: Copied (server-side copy) 2024/11/29 03:37:43 INFO : empty space: Deleted 2024/11/29 03:37:43 INFO : potato3: Deleted 2024/11/29 03:37:43 INFO : potato2: Deleted 2024/11/29 03:37:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qadamut2hela': Purge remote 2024/11/29 03:37:44 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:44 INFO : potato2.bin: Deleted 2024/11/29 03:37:44 INFO : empty space.bin: Deleted 2024/11/29 03:37:44 INFO : potato3.bin: Deleted 2024/11/29 03:37:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-difigul0fubu': Purge remote 2024/11/29 03:37:44 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (10.95s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xuhoviq3vuji" 2024/11/29 03:37:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xuhoviq3vuji.bin" 2024/11/29 03:37:45 DEBUG : Swift container crypt path rclone-test-xuhoviq3vuji.bin: Auto set use_segments_container to true 2024/11/29 03:37:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xuhoviq3vuji" 2024/11/29 03:37:46 DEBUG : Swift container crypt path rclone-test-xuhoviq3vuji: Auto set use_segments_container to true 2024/11/29 03:37:47 DEBUG : potato2: md5 = 53bf0aaa8c9d225c4c4da520b666e1e4 OK 2024/11/29 03:37:48 DEBUG : empty space: md5 = cae48a68cc0d8286446f671844080090 OK 2024/11/29 03:37:48 DEBUG : potato3: md5 = f019bcd42e1a8e4da29c114b3cc16423 OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema' -> Encrypted drive 'TestCryptSwift:rclone-test-xuhoviq3vuji' 2024/11/29 03:37:49 DEBUG : empty space: md5 = 651456586cfcd8358c8a3a6e90c044cd OK 2024/11/29 03:37:49 DEBUG : potato3: md5 = e15dee43c0bc68963daa77149112d227 OK 2024/11/29 03:37:50 DEBUG : empty space: Excluded (Size Filter) 2024/11/29 03:37:50 DEBUG : empty space: Excluded 2024/11/29 03:37:50 DEBUG : empty space: Excluded (Size Filter) 2024/11/29 03:37:50 DEBUG : empty space: Excluded 2024/11/29 03:37:50 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:50 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/29 03:37:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xuhoviq3vuji': Waiting for checks to finish 2024/11/29 03:37:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xuhoviq3vuji': Waiting for transfers to finish 2024/11/29 03:37:50 INFO : potato3: Copied (server-side copy) 2024/11/29 03:37:50 INFO : potato2: Copied (server-side copy) 2024/11/29 03:37:50 INFO : potato2: Deleted 2024/11/29 03:37:50 INFO : potato3: Deleted 2024/11/29 03:37:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-fuvugep5meri" 2024/11/29 03:37:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fuvugep5meri.bin" 2024/11/29 03:37:51 DEBUG : Swift container crypt path rclone-test-fuvugep5meri.bin: Auto set use_segments_container to true 2024/11/29 03:37:52 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fuvugep5meri" 2024/11/29 03:37:52 DEBUG : Swift container crypt path rclone-test-fuvugep5meri: Auto set use_segments_container to true 2024/11/29 03:37:53 DEBUG : empty space: Excluded (Size Filter) 2024/11/29 03:37:53 DEBUG : empty space: Excluded 2024/11/29 03:37:53 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:53 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/29 03:37:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fuvugep5meri': Waiting for checks to finish 2024/11/29 03:37:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fuvugep5meri': Waiting for transfers to finish 2024/11/29 03:37:53 INFO : potato2: Copied (server-side copy) 2024/11/29 03:37:53 INFO : potato2: Deleted 2024/11/29 03:37:54 INFO : potato3: Copied (server-side copy) 2024/11/29 03:37:54 INFO : potato3: Deleted 2024/11/29 03:37:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fuvugep5meri': Purge remote 2024/11/29 03:37:54 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:54 INFO : potato2.bin: Deleted 2024/11/29 03:37:54 INFO : potato3.bin: Deleted 2024/11/29 03:37:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xuhoviq3vuji': Purge remote 2024/11/29 03:37:54 DEBUG : Waiting for deletions to finish 2024/11/29 03:37:55 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (10.65s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:37:55 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-kejoyun3muvu" 2024/11/29 03:37:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kejoyun3muvu.bin" 2024/11/29 03:37:56 DEBUG : Swift container crypt path rclone-test-kejoyun3muvu.bin: Auto set use_segments_container to true 2024/11/29 03:37:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-kejoyun3muvu" 2024/11/29 03:37:57 DEBUG : Swift container crypt path rclone-test-kejoyun3muvu: Auto set use_segments_container to true 2024/11/29 03:37:57 DEBUG : potato2: md5 = 46e5e87fb9a2c1cb844595f25e9e738a OK 2024/11/29 03:37:57 DEBUG : empty space: md5 = b6f2ef69a5bac86449a180ad3f52a9f9 OK 2024/11/29 03:37:57 DEBUG : potato3: md5 = 4169f33ede635029230fe30f1f8f7756 OK 2024/11/29 03:37:57 DEBUG : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema' -> Encrypted drive 'TestCryptSwift:rclone-test-kejoyun3muvu' 2024/11/29 03:37:58 DEBUG : empty space: md5 = 43008f10cacaa619cc768accd99c4548 OK 2024/11/29 03:37:58 DEBUG : potato3: md5 = 41ba76ca582cb1209f7ccf8b0c761237 OK 2024/11/29 03:37:59 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:37:59 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/11/29 03:37:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kejoyun3muvu': Waiting for checks to finish 2024/11/29 03:37:59 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:37:59 DEBUG : empty space: Unchanged skipping 2024/11/29 03:37:59 INFO : empty space: Deleted 2024/11/29 03:37:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kejoyun3muvu': Waiting for transfers to finish 2024/11/29 03:37:59 INFO : potato2: Copied (server-side copy) 2024/11/29 03:37:59 INFO : potato3: Copied (server-side copy) 2024/11/29 03:37:59 INFO : potato2: Deleted 2024/11/29 03:38:00 INFO : potato3: Deleted 2024/11/29 03:38:00 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-xuzupov2hato" 2024/11/29 03:38:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xuzupov2hato.bin" 2024/11/29 03:38:01 DEBUG : Swift container crypt path rclone-test-xuzupov2hato.bin: Auto set use_segments_container to true 2024/11/29 03:38:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-xuzupov2hato" 2024/11/29 03:38:02 DEBUG : Swift container crypt path rclone-test-xuzupov2hato: Auto set use_segments_container to true 2024/11/29 03:38:02 DEBUG : tomatoDir: Making directory 2024/11/29 03:38:02 DEBUG : empty space: Need to transfer - File not found at Destination 2024/11/29 03:38:02 DEBUG : potato2: Need to transfer - File not found at Destination 2024/11/29 03:38:02 DEBUG : potato3: Need to transfer - File not found at Destination 2024/11/29 03:38:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xuzupov2hato': Waiting for checks to finish 2024/11/29 03:38:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xuzupov2hato': Waiting for transfers to finish 2024/11/29 03:38:03 INFO : empty space: Copied (server-side copy) 2024/11/29 03:38:03 INFO : potato3: Copied (server-side copy) 2024/11/29 03:38:03 INFO : potato2: Copied (server-side copy) 2024/11/29 03:38:03 INFO : empty space: Deleted 2024/11/29 03:38:03 INFO : potato3: Deleted 2024/11/29 03:38:03 INFO : potato2: Deleted 2024/11/29 03:38:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-xuzupov2hato': Purge remote 2024/11/29 03:38:03 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:03 INFO : potato3.bin: Deleted 2024/11/29 03:38:04 INFO : empty space.bin: Deleted 2024/11/29 03:38:04 INFO : potato2.bin: Deleted 2024/11/29 03:38:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-kejoyun3muvu': Purge remote 2024/11/29 03:38:04 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (9.22s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/rclone-move-test" 2024/11/29 03:38:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-move-test.bin" 2024/11/29 03:38:05 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-move-test.bin: Auto set use_segments_container to true 2024/11/29 03:38:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-move-test" 2024/11/29 03:38:06 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-move-test: Auto set use_segments_container to true 2024/11/29 03:38:06 DEBUG : potato2: md5 = e6416dc2cc11e40e4905ae67de778079 OK --- PASS: TestServerSideMoveOverlap (2.65s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test" 2024/11/29 03:38:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-sync-test.bin" 2024/11/29 03:38:07 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-sync-test.bin: Auto set use_segments_container to true 2024/11/29 03:38:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-sync-test" 2024/11/29 03:38:08 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncOverlap (2.49s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test" 2024/11/29 03:38:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-sync-test.bin" 2024/11/29 03:38:10 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-sync-test.bin: Auto set use_segments_container to true 2024/11/29 03:38:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-sync-test" 2024/11/29 03:38:11 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-sync-test: Auto set use_segments_container to true 2024/11/29 03:38:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test-include/layer2" 2024/11/29 03:38:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-sync-test-include/layer2.bin" 2024/11/29 03:38:11 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2024/11/29 03:38:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-sync-test-include/layer2" 2024/11/29 03:38:12 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2024/11/29 03:38:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test-ignore-file" 2024/11/29 03:38:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-sync-test-ignore-file.bin" 2024/11/29 03:38:13 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2024/11/29 03:38:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/rclone-sync-test-ignore-file" 2024/11/29 03:38:14 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2024/11/29 03:38:16 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = eaddc7d51059cbcb72a6f3819544c5d8 OK 2024/11/29 03:38:16 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/29 03:38:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test': Waiting for checks to finish 2024/11/29 03:38:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test': Waiting for transfers to finish 2024/11/29 03:38:16 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:16 INFO : There was nothing to transfer 2024/11/29 03:38:16 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/29 03:38:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:38:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:38:16 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:16 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:17 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/29 03:38:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test-include/layer2': Waiting for checks to finish 2024/11/29 03:38:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test-include/layer2': Waiting for transfers to finish 2024/11/29 03:38:17 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:17 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:17 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/29 03:38:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:38:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:38:17 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:17 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:17 DEBUG : : Excluded 2024/11/29 03:38:17 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/11/29 03:38:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test-ignore-file': Waiting for checks to finish 2024/11/29 03:38:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/rclone-sync-test-ignore-file': Waiting for transfers to finish 2024/11/29 03:38:17 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:17 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (10.82s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/dst" 2024/11/29 03:38:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst.bin" 2024/11/29 03:38:21 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst.bin: Auto set use_segments_container to true 2024/11/29 03:38:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst" 2024/11/29 03:38:22 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst: Auto set use_segments_container to true 2024/11/29 03:38:22 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/CompareDest" 2024/11/29 03:38:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/CompareDest.bin" 2024/11/29 03:38:23 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/CompareDest.bin: Auto set use_segments_container to true 2024/11/29 03:38:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/CompareDest" 2024/11/29 03:38:24 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/CompareDest: Auto set use_segments_container to true 2024/11/29 03:38:24 DEBUG : one: Need to transfer - File not found at Destination 2024/11/29 03:38:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:25 DEBUG : one: md5 = 45e777cc32dd48c9f8c4f2cc57694de9 OK 2024/11/29 03:38:25 INFO : one: Copied (new) 2024/11/29 03:38:25 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:25 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/29 03:38:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:25 DEBUG : one: md5 = 25e4b4feb72f1055ea6cfdefec4aaeda OK 2024/11/29 03:38:25 INFO : one: Copied (replaced existing) 2024/11/29 03:38:25 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:26 DEBUG : dst/one: md5 = ac7494448934fe54493e3bf90e5ebadd OK 2024/11/29 03:38:26 DEBUG : CompareDest/one: md5 = 2682fc58f51b8af3ee380f9d831988fd OK 2024/11/29 03:38:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:26 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/29 03:38:26 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:26 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/29 03:38:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:26 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:26 INFO : There was nothing to transfer 2024/11/29 03:38:27 DEBUG : CompareDest/two: md5 = 7acea0bb4753518946cde83af98907cd OK 2024/11/29 03:38:27 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:27 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/29 03:38:27 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/29 03:38:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:27 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:27 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/29 03:38:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:27 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:27 INFO : There was nothing to transfer 2024/11/29 03:38:28 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:28 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/29 03:38:28 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/29 03:38:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:28 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:28 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/29 03:38:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:28 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:28 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2024/11/29 03:38:28 DEBUG : two: Sizes differ (src 5 vs dst 3) 2024/11/29 03:38:28 DEBUG : two: Need to transfer - File not found at Destination 2024/11/29 03:38:28 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/29 03:38:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:28 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:28 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/29 03:38:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:29 DEBUG : two: md5 = cf0ad139ee8741f9922294171ddedb62 OK 2024/11/29 03:38:29 INFO : two: Copied (new) 2024/11/29 03:38:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (10.29s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:31 DEBUG : pre-dest1/1: md5 = 0476b77bb72406a3ff69344225c1d2f1 OK 2024/11/29 03:38:32 DEBUG : pre-dest2/2: md5 = f5565a571293f507c0efcb7a2ea9c315 OK 2024/11/29 03:38:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/dest" 2024/11/29 03:38:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dest.bin" 2024/11/29 03:38:33 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dest.bin: Auto set use_segments_container to true 2024/11/29 03:38:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dest" 2024/11/29 03:38:33 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dest: Auto set use_segments_container to true 2024/11/29 03:38:34 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/pre-dest1" 2024/11/29 03:38:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/pre-dest1.bin" 2024/11/29 03:38:35 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/pre-dest1.bin: Auto set use_segments_container to true 2024/11/29 03:38:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/pre-dest1" 2024/11/29 03:38:35 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/pre-dest1: Auto set use_segments_container to true 2024/11/29 03:38:36 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/pre-dest2" 2024/11/29 03:38:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/pre-dest2.bin" 2024/11/29 03:38:36 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/pre-dest2.bin: Auto set use_segments_container to true 2024/11/29 03:38:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/pre-dest2" 2024/11/29 03:38:38 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/pre-dest2: Auto set use_segments_container to true 2024/11/29 03:38:38 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:38 DEBUG : 1: Destination found in --compare-dest, skipping 2024/11/29 03:38:38 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:38 DEBUG : 2: Destination found in --compare-dest, skipping 2024/11/29 03:38:39 DEBUG : 3: Need to transfer - File not found at Destination 2024/11/29 03:38:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dest': Waiting for checks to finish 2024/11/29 03:38:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dest': Waiting for transfers to finish 2024/11/29 03:38:39 DEBUG : 3: md5 = 9063c120545b56477246b8e37355e0f0 OK 2024/11/29 03:38:39 INFO : 3: Copied (new) 2024/11/29 03:38:39 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (10.22s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:41 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/dst" 2024/11/29 03:38:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst.bin" 2024/11/29 03:38:41 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst.bin: Auto set use_segments_container to true 2024/11/29 03:38:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst" 2024/11/29 03:38:43 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst: Auto set use_segments_container to true 2024/11/29 03:38:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/CopyDest" 2024/11/29 03:38:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/CopyDest.bin" 2024/11/29 03:38:44 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/CopyDest.bin: Auto set use_segments_container to true 2024/11/29 03:38:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/CopyDest" 2024/11/29 03:38:45 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/CopyDest: Auto set use_segments_container to true 2024/11/29 03:38:45 DEBUG : one: Need to transfer - File not found at Destination 2024/11/29 03:38:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:45 DEBUG : one: md5 = 3d3dc6ab5916e6854564cf9382b06509 OK 2024/11/29 03:38:45 INFO : one: Copied (new) 2024/11/29 03:38:45 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:46 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/29 03:38:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:46 DEBUG : one: md5 = 97acbf617d4d2a42725533596a1f6a03 OK 2024/11/29 03:38:46 INFO : one: Copied (replaced existing) 2024/11/29 03:38:46 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:46 DEBUG : dst/one: md5 = 565685ad998a82b774a85686c48cff87 OK 2024/11/29 03:38:47 DEBUG : CopyDest/one: md5 = 5188391c8805e9c22ac28975aa6a0687 OK 2024/11/29 03:38:47 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/BackupDir" 2024/11/29 03:38:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/BackupDir.bin" 2024/11/29 03:38:48 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/BackupDir.bin: Auto set use_segments_container to true 2024/11/29 03:38:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/BackupDir" 2024/11/29 03:38:48 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/BackupDir: Auto set use_segments_container to true 2024/11/29 03:38:49 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/29 03:38:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:49 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:49 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/29 03:38:50 INFO : one: Copied (server-side copy) 2024/11/29 03:38:50 INFO : one: Deleted 2024/11/29 03:38:50 INFO : one: Copied (server-side copy) 2024/11/29 03:38:50 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/11/29 03:38:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:50 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:51 DEBUG : CopyDest/two: md5 = 72138597d0114e1700e928bc8a5f40c4 OK 2024/11/29 03:38:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:53 INFO : two: Copied (server-side copy) 2024/11/29 03:38:53 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/11/29 03:38:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:53 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:53 DEBUG : one: Unchanged skipping 2024/11/29 03:38:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:53 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:53 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:53 DEBUG : one: Unchanged skipping 2024/11/29 03:38:53 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:53 DEBUG : two: Unchanged skipping 2024/11/29 03:38:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:53 DEBUG : Waiting for deletions to finish 2024/11/29 03:38:53 INFO : There was nothing to transfer 2024/11/29 03:38:54 DEBUG : CopyDest/three: md5 = 5deb44b27c0c26815e3748d04f7163c2 OK 2024/11/29 03:38:54 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/11/29 03:38:54 DEBUG : three: Destination not found in --copy-dest 2024/11/29 03:38:54 DEBUG : three: Need to transfer - File not found at Destination 2024/11/29 03:38:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:38:55 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:55 DEBUG : two: Unchanged skipping 2024/11/29 03:38:55 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:38:55 DEBUG : one: Unchanged skipping 2024/11/29 03:38:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:38:55 DEBUG : three: md5 = 3aa621e0d81cb260af479e45d62366bd OK 2024/11/29 03:38:55 INFO : three: Copied (new) 2024/11/29 03:38:55 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (18.46s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:38:59 DEBUG : dst/one: md5 = 36d6db7b0ecdc019a4ecc9fde1fbc424 OK 2024/11/29 03:39:00 DEBUG : dst/two: md5 = 63a6841decf21b8c6b725694df59512b OK 2024/11/29 03:39:00 DEBUG : dst/three.txt: md5 = 5c2fd7d42749672c318b7d093180ac7f OK 2024/11/29 03:39:00 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst.bin" 2024/11/29 03:39:01 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst.bin: Auto set use_segments_container to true 2024/11/29 03:39:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:01 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst: Auto set use_segments_container to true 2024/11/29 03:39:02 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/backup" 2024/11/29 03:39:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/backup.bin" 2024/11/29 03:39:02 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/backup.bin: Auto set use_segments_container to true 2024/11/29 03:39:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/backup" 2024/11/29 03:39:03 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/backup: Auto set use_segments_container to true 2024/11/29 03:39:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:39:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/29 03:39:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:04 DEBUG : two: Unchanged skipping 2024/11/29 03:39:04 INFO : one: Copied (server-side copy) 2024/11/29 03:39:04 INFO : one: Deleted 2024/11/29 03:39:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:39:04 DEBUG : one: md5 = 1d0d479c88e9d73b92bee3c7219537f1 OK 2024/11/29 03:39:04 INFO : one: Copied (new) 2024/11/29 03:39:04 DEBUG : Waiting for deletions to finish 2024/11/29 03:39:05 INFO : three.txt: Copied (server-side copy) 2024/11/29 03:39:05 INFO : three.txt: Deleted 2024/11/29 03:39:05 INFO : three.txt: Moved into backup dir 2024/11/29 03:39:06 DEBUG : dst/three.txt: md5 = 913d0910c61c25009733e1df8911401c OK 2024/11/29 03:39:06 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/29 03:39:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:39:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:06 DEBUG : two: Unchanged skipping 2024/11/29 03:39:06 INFO : one: Copied (server-side copy) 2024/11/29 03:39:06 INFO : one: Deleted 2024/11/29 03:39:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:39:07 DEBUG : one: md5 = 15f4845a171c527972cd55ca3090458b OK 2024/11/29 03:39:07 INFO : one: Copied (new) 2024/11/29 03:39:07 DEBUG : Waiting for deletions to finish 2024/11/29 03:39:07 INFO : three.txt: Copied (server-side copy) 2024/11/29 03:39:07 INFO : three.txt: Deleted 2024/11/29 03:39:07 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (8.95s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:08 DEBUG : dst/one: md5 = e1ca67572e4a7590490725f913e8e44f OK 2024/11/29 03:39:08 DEBUG : dst/two: md5 = 47f29a1ea928f9b657675176625c017a OK 2024/11/29 03:39:09 DEBUG : dst/three.txt: md5 = 80b90648c7830e8507af7d8f01fa6288 OK 2024/11/29 03:39:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst.bin" 2024/11/29 03:39:09 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst.bin: Auto set use_segments_container to true 2024/11/29 03:39:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:10 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst: Auto set use_segments_container to true 2024/11/29 03:39:10 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/backup" 2024/11/29 03:39:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/backup.bin" 2024/11/29 03:39:11 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/backup.bin: Auto set use_segments_container to true 2024/11/29 03:39:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/backup" 2024/11/29 03:39:12 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/backup: Auto set use_segments_container to true 2024/11/29 03:39:12 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/29 03:39:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:39:12 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:12 DEBUG : two: Unchanged skipping 2024/11/29 03:39:13 INFO : one: Copied (server-side copy) to: one.bak 2024/11/29 03:39:13 INFO : one: Deleted 2024/11/29 03:39:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:39:13 DEBUG : one: md5 = 8b4c9df96f3a97b0225a369e5d28e771 OK 2024/11/29 03:39:13 INFO : one: Copied (new) 2024/11/29 03:39:13 DEBUG : Waiting for deletions to finish 2024/11/29 03:39:14 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/29 03:39:14 INFO : three.txt: Deleted 2024/11/29 03:39:14 INFO : three.txt: Moved into backup dir 2024/11/29 03:39:15 DEBUG : dst/three.txt: md5 = da39106dc440fdfc7980888fb2c30ccf OK 2024/11/29 03:39:15 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/29 03:39:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:39:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:15 DEBUG : two: Unchanged skipping 2024/11/29 03:39:16 INFO : one: Copied (server-side copy) to: one.bak 2024/11/29 03:39:16 INFO : one: Deleted 2024/11/29 03:39:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:39:16 DEBUG : one: md5 = 06bbdd2539671bd578a1d8100066a404 OK 2024/11/29 03:39:16 INFO : one: Copied (new) 2024/11/29 03:39:16 DEBUG : Waiting for deletions to finish 2024/11/29 03:39:16 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/29 03:39:16 INFO : three.txt: Deleted 2024/11/29 03:39:16 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (9.23s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:17 DEBUG : dst/one: md5 = 98333e1e2da320cd17a396fc302947cc OK 2024/11/29 03:39:18 DEBUG : dst/two: md5 = ae5135f62d67a4fd95f02c161e4bf167 OK 2024/11/29 03:39:18 DEBUG : dst/three.txt: md5 = eb0fab6432d5456278cef1b958281292 OK 2024/11/29 03:39:18 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst.bin" 2024/11/29 03:39:19 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst.bin: Auto set use_segments_container to true 2024/11/29 03:39:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:19 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst: Auto set use_segments_container to true 2024/11/29 03:39:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/backup" 2024/11/29 03:39:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/backup.bin" 2024/11/29 03:39:20 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/backup.bin: Auto set use_segments_container to true 2024/11/29 03:39:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/backup" 2024/11/29 03:39:21 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/backup: Auto set use_segments_container to true 2024/11/29 03:39:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/29 03:39:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:39:21 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:21 DEBUG : two: Unchanged skipping 2024/11/29 03:39:22 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/29 03:39:22 INFO : one: Deleted 2024/11/29 03:39:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:39:22 DEBUG : one: md5 = 7049bc0679beca8bb6ef467b4a464ab4 OK 2024/11/29 03:39:22 INFO : one: Copied (new) 2024/11/29 03:39:22 DEBUG : Waiting for deletions to finish 2024/11/29 03:39:23 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/29 03:39:23 INFO : three.txt: Deleted 2024/11/29 03:39:23 INFO : three.txt: Moved into backup dir 2024/11/29 03:39:24 DEBUG : dst/three.txt: md5 = 960b6efdee3592f1a6752e77b419f3de OK 2024/11/29 03:39:24 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/29 03:39:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:39:24 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:24 DEBUG : two: Unchanged skipping 2024/11/29 03:39:25 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/29 03:39:25 INFO : one: Deleted 2024/11/29 03:39:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:39:25 DEBUG : one: md5 = a9395495b640b322c8853f7ffb7c8762 OK 2024/11/29 03:39:25 INFO : one: Copied (new) 2024/11/29 03:39:25 DEBUG : Waiting for deletions to finish 2024/11/29 03:39:25 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/29 03:39:25 INFO : three.txt: Deleted 2024/11/29 03:39:25 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (9.06s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:27 DEBUG : dst/one: md5 = 88214d222a36211b935748843b309d2c OK 2024/11/29 03:39:27 DEBUG : dst/two: md5 = 8035396c6c75766e3298b098a4b94754 OK 2024/11/29 03:39:27 DEBUG : dst/three.txt: md5 = aa9a73debd805421e908954d09c1bd9f OK 2024/11/29 03:39:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst.bin" 2024/11/29 03:39:28 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst.bin: Auto set use_segments_container to true 2024/11/29 03:39:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:28 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst: Auto set use_segments_container to true 2024/11/29 03:39:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/29 03:39:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:39:29 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:29 DEBUG : two: Unchanged skipping 2024/11/29 03:39:29 INFO : one: Copied (server-side copy) to: one.bak 2024/11/29 03:39:29 INFO : one: Deleted 2024/11/29 03:39:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:39:29 DEBUG : one: md5 = b194bb7d7d2b5bf267277e9eb714d831 OK 2024/11/29 03:39:29 INFO : one: Copied (new) 2024/11/29 03:39:29 DEBUG : Waiting for deletions to finish 2024/11/29 03:39:30 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/29 03:39:30 INFO : three.txt: Deleted 2024/11/29 03:39:30 INFO : three.txt: Moved into backup dir 2024/11/29 03:39:31 DEBUG : dst/three.txt: md5 = 0d0775001e4c7ba0f523a07abeffe2e7 OK 2024/11/29 03:39:31 DEBUG : one.bak: Excluded (Path Filter) 2024/11/29 03:39:31 DEBUG : one.bak: Excluded 2024/11/29 03:39:31 DEBUG : three.txt.bak: Excluded (Path Filter) 2024/11/29 03:39:31 DEBUG : three.txt.bak: Excluded 2024/11/29 03:39:31 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/29 03:39:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for checks to finish 2024/11/29 03:39:31 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:31 DEBUG : two: Unchanged skipping 2024/11/29 03:39:32 INFO : one: Copied (server-side copy) to: one.bak 2024/11/29 03:39:32 INFO : one: Deleted 2024/11/29 03:39:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema/dst': Waiting for transfers to finish 2024/11/29 03:39:32 DEBUG : one: md5 = d22d89124cf973804e50f3c0fba97ae2 OK 2024/11/29 03:39:32 INFO : one: Copied (new) 2024/11/29 03:39:32 DEBUG : Waiting for deletions to finish 2024/11/29 03:39:32 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/29 03:39:32 INFO : three.txt: Deleted 2024/11/29 03:39:32 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (6.81s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:33 DEBUG : dst/one: md5 = 473dc936a8b575c479008cbb291537e6 OK 2024/11/29 03:39:33 DEBUG : dst/two: md5 = 36e4a14d478f6cfd7d8089e9f17b7905 OK 2024/11/29 03:39:34 DEBUG : dst/three.txt: md5 = 1a930b92700ba2b4e59881e8a03184a2 OK 2024/11/29 03:39:34 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst.bin" 2024/11/29 03:39:34 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst.bin: Auto set use_segments_container to true 2024/11/29 03:39:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:35 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst: Auto set use_segments_container to true 2024/11/29 03:39:35 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/29 03:39:36 INFO : one: Copied (server-side copy) to: one.bak 2024/11/29 03:39:36 INFO : one: Deleted 2024/11/29 03:39:36 DEBUG : one: md5 = 98236a65b7d4187e828e587b6b19dab1 OK 2024/11/29 03:39:36 INFO : one: Copied (new) 2024/11/29 03:39:36 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:36 DEBUG : two: Unchanged skipping 2024/11/29 03:39:36 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/11/29 03:39:36 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/29 03:39:36 INFO : three.txt: Deleted 2024/11/29 03:39:37 DEBUG : three.txt: md5 = b9742d2619b1f4825c281b0b718f816f OK 2024/11/29 03:39:37 INFO : three.txt: Copied (new) 2024/11/29 03:39:37 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/29 03:39:38 INFO : one: Copied (server-side copy) to: one.bak 2024/11/29 03:39:38 INFO : one: Deleted 2024/11/29 03:39:38 DEBUG : one: md5 = 65910621c63537320ad89b7873e9074d OK 2024/11/29 03:39:38 INFO : one: Copied (new) 2024/11/29 03:39:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:38 DEBUG : two: Unchanged skipping 2024/11/29 03:39:38 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/11/29 03:39:38 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/11/29 03:39:38 INFO : three.txt: Deleted 2024/11/29 03:39:38 DEBUG : three.txt: md5 = 2cf97307cccc74ec73f6de9e8025fcea OK 2024/11/29 03:39:38 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (6.46s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:40 DEBUG : dst/one: md5 = 39e77604c5c55cac809584e45b0fe6bb OK 2024/11/29 03:39:40 DEBUG : dst/two: md5 = c152c7afed4c8040c8d211b1bd816de5 OK 2024/11/29 03:39:40 DEBUG : dst/three.txt: md5 = f456f9469bc60cce58e943978dfcaa86 OK 2024/11/29 03:39:41 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst.bin" 2024/11/29 03:39:41 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst.bin: Auto set use_segments_container to true 2024/11/29 03:39:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-voxaleb6gema/dst" 2024/11/29 03:39:42 DEBUG : Swift container crypt path rclone-test-voxaleb6gema/dst: Auto set use_segments_container to true 2024/11/29 03:39:42 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/11/29 03:39:43 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/29 03:39:43 INFO : one: Deleted 2024/11/29 03:39:43 DEBUG : one: md5 = 054e0b9a4271d8f98715f9215c540eba OK 2024/11/29 03:39:43 INFO : one: Copied (new) 2024/11/29 03:39:43 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:43 DEBUG : two: Unchanged skipping 2024/11/29 03:39:43 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/11/29 03:39:44 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/29 03:39:44 INFO : three.txt: Deleted 2024/11/29 03:39:44 DEBUG : three.txt: md5 = 017884d058a6299f3bd47310653e75b6 OK 2024/11/29 03:39:44 INFO : three.txt: Copied (new) 2024/11/29 03:39:45 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/11/29 03:39:45 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/11/29 03:39:45 INFO : one: Deleted 2024/11/29 03:39:45 DEBUG : one: md5 = e758a3a1bbc0702aed7d2294473cffc1 OK 2024/11/29 03:39:45 INFO : one: Copied (new) 2024/11/29 03:39:45 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:45 DEBUG : two: Unchanged skipping 2024/11/29 03:39:45 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/11/29 03:39:46 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/11/29 03:39:46 INFO : three.txt: Deleted 2024/11/29 03:39:46 DEBUG : three.txt: md5 = 67db2334d81a84342216815c6078c7f2 OK 2024/11/29 03:39:46 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (7.83s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:48 DEBUG : Testêé: md5 = 9be5ff01536831bcc703fca442168ff8 OK 2024/11/29 03:39:48 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/11/29 03:39:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:39:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:39:49 DEBUG : Testêé: md5 = 3b79785cae3bae619233bc422c87b995 OK 2024/11/29 03:39:49 INFO : Testêé: Copied (replaced existing) to: Testêé 2024/11/29 03:39:49 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (1.57s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:49 DEBUG : existing: Need to transfer - File not found at Destination 2024/11/29 03:39:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:39:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:39:50 DEBUG : existing: md5 = f9d01f9d5d89ef54333e44c9fad7a7da OK 2024/11/29 03:39:50 INFO : existing: Copied (new) 2024/11/29 03:39:50 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:50 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2024/11/29 03:39:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:39:50 ERROR : existing: Source and destination exist but do not match: immutable file modified 2024/11/29 03:39:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:39:50 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': not deleting files as there were IO errors 2024/11/29 03:39:50 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncImmutable (2.24s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:52 DEBUG : EXISTING: md5 = e8ae9af46ead7cf26146e177008a9b5d OK 2024/11/29 03:39:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:39:52 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:39:52 DEBUG : existing: Unchanged skipping 2024/11/29 03:39:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:39:52 DEBUG : Waiting for deletions to finish 2024/11/29 03:39:52 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.20s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.17s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.37s) --- SKIP: TestMaxTransfer/Hard (0.09s) --- SKIP: TestMaxTransfer/Soft (0.09s) --- SKIP: TestMaxTransfer/Cautious (0.19s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:39:53 DEBUG : both0: md5 = e103ad81f53d4032cf497b468ef49610 OK 2024/11/29 03:39:54 DEBUG : only0: md5 = ff746dc006940474ddedd4b661abf8e8 OK 2024/11/29 03:39:54 DEBUG : both1: md5 = 77f4e12f540cc32032656b9e7aa4e4e5 OK 2024/11/29 03:39:55 DEBUG : only1: md5 = 527f670fecb1815ca7b2c6c2a29730ee OK 2024/11/29 03:39:56 DEBUG : both2: md5 = 237075a6d89ff2644dabe4366415f6d9 OK 2024/11/29 03:39:56 DEBUG : only2: md5 = 47f24ae0f8d13a18986b3c6cff3a6899 OK 2024/11/29 03:39:57 DEBUG : both3: md5 = 6123e3a95e4736b98295891c941b0d3d OK 2024/11/29 03:39:58 DEBUG : only3: md5 = 31c5bac44021f40983b2c2b6db7341f6 OK 2024/11/29 03:39:58 DEBUG : both4: md5 = ab6c1bc339ab526169a4bb66e4d417a9 OK 2024/11/29 03:39:58 DEBUG : only4: md5 = 92e2dbb7f38748a8a1e30e0054d3aed7 OK 2024/11/29 03:39:59 DEBUG : both5: md5 = ef208b6a88283caf9e96cf12507d6ddd OK 2024/11/29 03:39:59 DEBUG : only5: md5 = 4bb2b7b89235f8ee1b9ad2a73814b394 OK 2024/11/29 03:40:00 DEBUG : both6: md5 = cf3c24b6f4ba55af58cf9b59d7372e03 OK 2024/11/29 03:40:01 DEBUG : only6: md5 = 43e03e394fc36460b8d956f2f4405ed6 OK 2024/11/29 03:40:01 DEBUG : both7: md5 = 8736f0a050b4acf03331957ce9453ae3 OK 2024/11/29 03:40:02 DEBUG : only7: md5 = e1f03fb78764a6670a48e03251c135df OK 2024/11/29 03:40:02 DEBUG : both8: md5 = b69bbbd7dae5cf4a9993435ec7370f76 OK 2024/11/29 03:40:03 DEBUG : only8: md5 = 34e03f8f2ddadc32f3947891829921ee OK 2024/11/29 03:40:04 DEBUG : both9: md5 = 6dc6f2277489d0d11ed1fbd3d4d41d95 OK 2024/11/29 03:40:04 DEBUG : only9: md5 = b4e868edd6307f44a598609115163e44 OK 2024/11/29 03:40:05 DEBUG : both10: md5 = 30abfd7fe2dae14376c9f5130238b053 OK 2024/11/29 03:40:05 DEBUG : only10: md5 = cb67f855755085ea3c101c70034c47f8 OK 2024/11/29 03:40:06 DEBUG : both11: md5 = d670fcc07172c4df81d8eca44daa5207 OK 2024/11/29 03:40:06 DEBUG : only11: md5 = 871f86035ed06553f25ef875caa06058 OK 2024/11/29 03:40:07 DEBUG : both12: md5 = 8b974caa2953dca595b37d8fbe377f42 OK 2024/11/29 03:40:07 DEBUG : only12: md5 = 96b8b7e01c70057cdd68529543b8e397 OK 2024/11/29 03:40:07 DEBUG : both13: md5 = 2c6a048c2d1b329fb0ea099172150a93 OK 2024/11/29 03:40:08 DEBUG : only13: md5 = e0361560f772058059624049e9511ff6 OK 2024/11/29 03:40:09 DEBUG : both14: md5 = d3b73b668a5ff5139c2daf9e53013079 OK 2024/11/29 03:40:09 DEBUG : only14: md5 = cfb23230e33b405cc8f65bdd58554667 OK 2024/11/29 03:40:09 DEBUG : both15: md5 = 253ebf048aa9c87d88866981d5f15611 OK 2024/11/29 03:40:10 DEBUG : only15: md5 = f40078d5b2f1860cc92d21478acddbe8 OK 2024/11/29 03:40:11 DEBUG : both16: md5 = b2a2b8fe2a7a5b96fc1f2978f0da163f OK 2024/11/29 03:40:11 DEBUG : only16: md5 = 30d429ae299d97bb56e07fe7804abb2f OK 2024/11/29 03:40:11 DEBUG : both17: md5 = 4184f9d6fdaf07aa60a382bbd73dfee8 OK 2024/11/29 03:40:13 DEBUG : only17: md5 = 88919411d2f1eff2c80ae032a7723f87 OK 2024/11/29 03:40:14 DEBUG : both18: md5 = 721ff2b2b0c405bc91258fe102a89ff5 OK 2024/11/29 03:40:14 DEBUG : only18: md5 = e2c59f07fe4b2515542dd0545072ec2a OK 2024/11/29 03:40:14 DEBUG : both19: md5 = 10f394e0302883e1d6980179a8e8e861 OK 2024/11/29 03:40:16 DEBUG : only19: md5 = d3c8c76c31429f09926870c1555645f6 OK 2024/11/29 03:40:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:40:18 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both0: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both1: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both10: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both11: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both12: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both13: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both14: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both15: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both16: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both17: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both18: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both19: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both3: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both2: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both4: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both5: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both6: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both7: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both8: Unchanged skipping 2024/11/29 03:40:18 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:18 DEBUG : both9: Unchanged skipping 2024/11/29 03:40:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:40:18 DEBUG : Waiting for deletions to finish 2024/11/29 03:40:18 INFO : only10: Deleted 2024/11/29 03:40:18 INFO : only14: Deleted 2024/11/29 03:40:18 INFO : only19: Deleted 2024/11/29 03:40:18 INFO : only17: Deleted 2024/11/29 03:40:18 INFO : only18: Deleted 2024/11/29 03:40:18 INFO : only4: Deleted 2024/11/29 03:40:18 INFO : only5: Deleted 2024/11/29 03:40:19 INFO : only8: Deleted 2024/11/29 03:40:19 INFO : only1: Deleted 2024/11/29 03:40:19 INFO : only11: Deleted 2024/11/29 03:40:19 INFO : only13: Deleted 2024/11/29 03:40:19 INFO : only9: Deleted 2024/11/29 03:40:19 INFO : only7: Deleted 2024/11/29 03:40:19 INFO : only0: Deleted 2024/11/29 03:40:19 INFO : only12: Deleted 2024/11/29 03:40:19 INFO : only16: Deleted 2024/11/29 03:40:20 INFO : only6: Deleted 2024/11/29 03:40:20 INFO : only15: Deleted 2024/11/29 03:40:20 INFO : only2: Deleted 2024/11/29 03:40:20 INFO : only3: Deleted 2024/11/29 03:40:20 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (32.84s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:40:26 DEBUG : both0: md5 = 547ef7955f14b69d6ded8ba2cea4a496 OK 2024/11/29 03:40:26 DEBUG : only0: md5 = 00c63d9a37021c2fe82b874721450885 OK 2024/11/29 03:40:27 DEBUG : both1: md5 = 5a8fca58173a7f29a0f21f5bdb591d49 OK 2024/11/29 03:40:27 DEBUG : only1: md5 = c40dabe837a9dd415b57d8640edb23a9 OK 2024/11/29 03:40:27 DEBUG : both2: md5 = cb12cd416dcd38f439113cb80d681b40 OK 2024/11/29 03:40:27 DEBUG : only2: md5 = 88119552214795ca6f9d22b2d0432c6f OK 2024/11/29 03:40:27 DEBUG : both3: md5 = ba377e2788904b70131e702a72b22a4f OK 2024/11/29 03:40:28 DEBUG : only3: md5 = 6d6929de10f65178ee46107a53f15326 OK 2024/11/29 03:40:28 DEBUG : both4: md5 = 738a87953d1310803fb692be8ad2b3b3 OK 2024/11/29 03:40:28 DEBUG : only4: md5 = c8d202b5cac9f09ce754b5727fb86ff8 OK 2024/11/29 03:40:28 DEBUG : both5: md5 = 25f046af5e27c9fc6ba45e76a7dcae77 OK 2024/11/29 03:40:29 DEBUG : only5: md5 = ab4df4a8a5e1569601ff0de0910e27b3 OK 2024/11/29 03:40:29 DEBUG : both6: md5 = ef4a8bdae44afc77fad0e008d6ffb82e OK 2024/11/29 03:40:29 DEBUG : only6: md5 = f141d321af53024bb84b4241030699ad OK 2024/11/29 03:40:29 DEBUG : both7: md5 = a1e7b5d5ed9f3d06ed44ea6cfdebdde7 OK 2024/11/29 03:40:29 DEBUG : only7: md5 = 590f9ef40247838d34236fd35ee3a9c9 OK 2024/11/29 03:40:30 DEBUG : both8: md5 = 58ab5086e998ad6c15bdbee625b6d920 OK 2024/11/29 03:40:30 DEBUG : only8: md5 = 4938ed44309283e23b87688d3ab61956 OK 2024/11/29 03:40:30 DEBUG : both9: md5 = 8b4e388965cd4d865ea9ccbe48a1e958 OK 2024/11/29 03:40:30 DEBUG : only9: md5 = fedad0d6a48f1c7ed1634228ab312298 OK 2024/11/29 03:40:31 DEBUG : both10: md5 = 0a76064bfb333362b077a57c52e49219 OK 2024/11/29 03:40:31 DEBUG : only10: md5 = 8c4ea33ea266e55813fff6174e00629d OK 2024/11/29 03:40:31 DEBUG : both11: md5 = 6fbc25a9370e7100d19bd7cf6e8a4697 OK 2024/11/29 03:40:31 DEBUG : only11: md5 = 4df9914ab943a888fe4d6dad43c1c14e OK 2024/11/29 03:40:31 DEBUG : both12: md5 = 545f5d3e23eb0820b7b95862a2fd7b91 OK 2024/11/29 03:40:32 DEBUG : only12: md5 = a85f57c36bde383488048071daf98b4f OK 2024/11/29 03:40:32 DEBUG : both13: md5 = 3514a69605b102d5cd1ecedd1ad1bc12 OK 2024/11/29 03:40:32 DEBUG : only13: md5 = 00357b8959af2167fe57db481924aaba OK 2024/11/29 03:40:32 DEBUG : both14: md5 = b7f1aa296bf1166b9564daf8227219c8 OK 2024/11/29 03:40:32 DEBUG : only14: md5 = 9bf903be2b981609c60db732a96fcf1f OK 2024/11/29 03:40:32 DEBUG : both15: md5 = 1ce40aec0a6031d6bd3ffaa3c141756c OK 2024/11/29 03:40:33 DEBUG : only15: md5 = 8a984d710136f56da9e734eba25b3aa5 OK 2024/11/29 03:40:33 DEBUG : both16: md5 = 0731a8cdbe1747ceb7de88ba2b442dcc OK 2024/11/29 03:40:33 DEBUG : only16: md5 = f8a62fbeff210ab9eccf8df582f12805 OK 2024/11/29 03:40:33 DEBUG : both17: md5 = 1abe065d17296a3d557f5a95b8eb18da OK 2024/11/29 03:40:33 DEBUG : only17: md5 = 0f4b2b594220e8de7db0b18f5f8c1e9d OK 2024/11/29 03:40:34 DEBUG : both18: md5 = 00d6dde22a665f2c3723d2e686945930 OK 2024/11/29 03:40:34 DEBUG : only18: md5 = 033c2d9a657360c292ed35f9974803cd OK 2024/11/29 03:40:34 DEBUG : both19: md5 = 89b67ade5a4d02e4bb8e4461b4bfbfaf OK 2024/11/29 03:40:34 DEBUG : only19: md5 = 0fff6166d824fc56e4e836852fc7e5a5 OK 2024/11/29 03:40:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for checks to finish 2024/11/29 03:40:36 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both1: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both10: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both11: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both0: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both12: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both14: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both13: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both15: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both17: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both16: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both18: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both19: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both2: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both3: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both4: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both5: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both6: Unchanged skipping 2024/11/29 03:40:36 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both7: Unchanged skipping 2024/11/29 03:40:36 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2024/11/29 03:40:36 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both8: Unchanged skipping 2024/11/29 03:40:36 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/29 03:40:36 DEBUG : both9: Unchanged skipping 2024/11/29 03:40:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Waiting for transfers to finish 2024/11/29 03:40:37 DEBUG : only0: md5 = 17ffd753bfe009643025e3ea7866e977 OK 2024/11/29 03:40:37 INFO : only0: Copied (replaced existing) 2024/11/29 03:40:37 DEBUG : only11: md5 = fa077a8499ebfadf9c396abd9bd3cd14 OK 2024/11/29 03:40:37 INFO : only11: Copied (replaced existing) 2024/11/29 03:40:37 DEBUG : only1: md5 = 9007e870c5e35204b2203f4a5a9f438e OK 2024/11/29 03:40:37 INFO : only1: Copied (replaced existing) 2024/11/29 03:40:37 DEBUG : only10: md5 = 2ee7d73b03f3fbd7a002da60f36e8261 OK 2024/11/29 03:40:37 INFO : only10: Copied (replaced existing) 2024/11/29 03:40:37 DEBUG : only12: md5 = 9c3748a2fa4ff09e7dbedaadeaf4d9e1 OK 2024/11/29 03:40:37 INFO : only12: Copied (replaced existing) 2024/11/29 03:40:37 DEBUG : only13: md5 = 72213a42f53d8385d26dfc5bfdf7ddc6 OK 2024/11/29 03:40:37 INFO : only13: Copied (replaced existing) 2024/11/29 03:40:37 DEBUG : only14: md5 = d4b08f2a9fc08e075becdb5bb7b29d11 OK 2024/11/29 03:40:37 INFO : only14: Copied (replaced existing) 2024/11/29 03:40:37 DEBUG : only15: md5 = caf6bf236c12e3cb28df5f66c3dc87d2 OK 2024/11/29 03:40:37 INFO : only15: Copied (replaced existing) 2024/11/29 03:40:37 DEBUG : only16: md5 = aa8f088bef46a64f01946cb422e55340 OK 2024/11/29 03:40:37 INFO : only16: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only18: md5 = 0d64562019ba22a8f0855f1774aca108 OK 2024/11/29 03:40:38 INFO : only18: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only17: md5 = f9cbe1da3c2497a30424cffc5ca26c87 OK 2024/11/29 03:40:38 INFO : only17: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only2: md5 = c11fc3fe0be6b75834b216bee8a69171 OK 2024/11/29 03:40:38 INFO : only2: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only19: md5 = 665d3ea95b227c9b54814f4f2b7e4430 OK 2024/11/29 03:40:38 INFO : only19: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only3: md5 = d126183f775e6c12344cb4fb21cf50c7 OK 2024/11/29 03:40:38 INFO : only3: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only4: md5 = 2e25f2ba93c08a8d7220c2daabcfc5a5 OK 2024/11/29 03:40:38 INFO : only4: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only6: md5 = dfd2f3f325c1c115ff5394137fe2c60e OK 2024/11/29 03:40:38 INFO : only6: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only7: md5 = 6c3fd80d2ac43e5fadcd5513b8757c5d OK 2024/11/29 03:40:38 INFO : only7: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only8: md5 = ef4aa6497bfd3830d288e667f245a200 OK 2024/11/29 03:40:38 INFO : only8: Copied (replaced existing) 2024/11/29 03:40:38 DEBUG : only9: md5 = 8e5da3f0ee4b846ef8e492d5edd609e5 OK 2024/11/29 03:40:38 INFO : only9: Copied (replaced existing) 2024/11/29 03:40:39 DEBUG : only5: md5 = e1bdac42ac4142b141cdbd4d9dcb5e37 OK 2024/11/29 03:40:39 INFO : only5: Copied (replaced existing) 2024/11/29 03:40:39 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (22.34s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:40:48 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/29 03:40:48 DEBUG : sub dir: Making directory 2024/11/29 03:40:48 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (2.19s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" 2024/11/29 03:40:50 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/11/29 03:40:50 DEBUG : sub dir: Making directory 2024/11/29 03:40:50 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema'", Local "Local file system at /tmp/rclone1727897325", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (1.97s) PASS 2024/11/29 03:40:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-voxaleb6gema': Purge remote 2024/11/29 03:40:52 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 4m59.837304363s (try 1/5)