"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2025/03/13 04:29:49 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe" 2025/03/13 04:29:49 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/13 04:29:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe.bin" 2025/03/13 04:29:50 DEBUG : Swift container crypt path rclone-test-wihurer3lipe.bin: Auto set use_segments_container to true 2025/03/13 04:29:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe" 2025/03/13 04:29:51 DEBUG : Swift container crypt path rclone-test-wihurer3lipe: Auto set use_segments_container to true 2025/03/13 04:29:51 DEBUG : Creating backend with remote "/tmp/rclone329930444" === 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-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:29:52 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:29:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:29:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:29:52 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.60s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:29:52 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/13 04:29:52 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:29:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:29:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:29:52 DEBUG : sub dir/hello world: md5 = 87b95573dd87ceb1dbfbf0b8f7d56d93 OK 2025/03/13 04:29:52 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:29:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (1.10s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.31s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.10s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:29:54 DEBUG : Creating backend with remote "/non-existing" 2025/03/13 04:29:54 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/03/13 04:29:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:29:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.24s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:29:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:29:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:29:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:29:54 DEBUG : sub dir/hello world: md5 = 6b1e02352e005276ae079aea406ce259 OK 2025/03/13 04:29:54 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyNoTraverse (1.07s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:29:55 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Running all checks before starting transfers 2025/03/13 04:29:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:29:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:29:55 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Checks finished, now starting transfers 2025/03/13 04:29:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:29:55 DEBUG : sub dir/hello world: md5 = 859114da889b357af08fb2cc77605cae OK 2025/03/13 04:29:55 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyCheckFirst (1.02s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:29:56 ERROR : Ignoring --no-traverse with sync 2025/03/13 04:29:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:29:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:29:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:29:56 DEBUG : sub dir/hello world: md5 = 81ccae1a30e0230874ee66a6eade43fd OK 2025/03/13 04:29:56 INFO : sub dir/hello world: Copied (new) 2025/03/13 04:29:56 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncNoTraverse (1.15s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:29:57 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/03/13 04:29:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:29:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:29:59 DEBUG : hello world2: md5 = 81701960030cc8af17efbd42d35bc02c OK 2025/03/13 04:29:59 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyWithDepth (2.28s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:29:59 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:29:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:29:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:00 DEBUG : potato2: md5 = 5782cd486eff16999bf97d691977ba94 OK 2025/03/13 04:30:00 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (1.04s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:00 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:30:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:01 DEBUG : potato2: md5 = a64b10ccea6fde856c393abab38c3c03 OK 2025/03/13 04:30:01 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (0.91s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:01 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/03/13 04:30:01 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/13 04:30:01 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/03/13 04:30:01 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/13 04:30:01 INFO : sub dir: Making directory 2025/03/13 04:30:01 INFO : sub dir2: Making directory 2025/03/13 04:30:01 INFO : sub dir2/sub sub dir2: Making directory 2025/03/13 04:30:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:01 DEBUG : sub dir/hello world: md5 = 45fe3dd53fdd9e50955ef8f3e64fd9b4 OK 2025/03/13 04:30:01 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2025/03/13 04:30:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (0.91s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:02 INFO : sub dir2: Making directory 2025/03/13 04:30:02 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/03/13 04:30:02 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/13 04:30:02 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:02 DEBUG : sub dir/hello world: md5 = 1584cb5ff9f5492876ebe225837b22d1 OK 2025/03/13 04:30:02 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (0.85s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:03 DEBUG : sub dir2: Making directory with metadata 2025/03/13 04:30:03 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/13 04:30:03 INFO : sub dir: Making directory 2025/03/13 04:30:03 INFO : sub dir2: Making directory 2025/03/13 04:30:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:03 DEBUG : sub dir/hello world: md5 = 854c31e9ef364ef51daef9e4b62644c8 OK 2025/03/13 04:30:03 INFO : sub dir/hello world: Copied (new) 2025/03/13 04:30:03 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/03/13 04:30:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/03/13 04:30:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.34s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.19s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:05 INFO : sub dir2: Making directory 2025/03/13 04:30:05 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:05 DEBUG : sub dir/hello world: md5 = 1abf5f43af59922484c54050eaebb30a OK 2025/03/13 04:30:05 INFO : sub dir/hello world: Copied (new) 2025/03/13 04:30:05 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (0.85s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:05 DEBUG : sub dir2: Making directory with metadata 2025/03/13 04:30:05 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/13 04:30:05 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/13 04:30:06 INFO : sub dir: Making directory 2025/03/13 04:30:06 INFO : sub dir2: Making directory 2025/03/13 04:30:06 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:06 DEBUG : sub dir/hello world: md5 = b47a0dfa59ccaabfd1f5e18e5b448de1 OK 2025/03/13 04:30:06 INFO : sub dir/hello world: Copied (new) 2025/03/13 04:30:06 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2025/03/13 04:30:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.09s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:507: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.10s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:07 INFO : sub dir2: Making directory 2025/03/13 04:30:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:07 DEBUG : sub dir/hello world: md5 = 912360f4f72bea20b5043c3e6db4d8d0 OK 2025/03/13 04:30:07 INFO : sub dir/hello world: Copied (new) 2025/03/13 04:30:07 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (0.81s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:08 DEBUG : sub dir/hello world: md5 = 5812dd5cc913e3a55b19167a88aa1ef5 OK 2025/03/13 04:30:08 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-davofad1luxu" 2025/03/13 04:30:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-davofad1luxu.bin" 2025/03/13 04:30:09 DEBUG : Swift container crypt path rclone-test-davofad1luxu.bin: Auto set use_segments_container to true 2025/03/13 04:30:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-davofad1luxu" 2025/03/13 04:30:09 DEBUG : Swift container crypt path rclone-test-davofad1luxu: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe' -> Encrypted drive 'TestCryptSwift:rclone-test-davofad1luxu' 2025/03/13 04:30:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-davofad1luxu': Waiting for checks to finish 2025/03/13 04:30:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-davofad1luxu': Waiting for transfers to finish 2025/03/13 04:30:10 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-davofad1luxu': Purge remote 2025/03/13 04:30:11 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:11 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (4.03s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:12 DEBUG : sub dir/hello world: md5 = 4524e6927b3c5e4073cc1cd54c079c40 OK 2025/03/13 04:30:12 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/13 04:30:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:12 DEBUG : sub dir/hello world: md5 = 3d29f82af5f89cb30f99f3c07e3a09c1 OK 2025/03/13 04:30:12 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyOverSelf (1.74s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:13 DEBUG : sub dir/hello world: md5 = c1c7d6d46eb569cab853f240d31c36e9 OK 2025/03/13 04:30:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-goyafuj8pozi" 2025/03/13 04:30:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-goyafuj8pozi.bin" 2025/03/13 04:30:14 DEBUG : Swift container crypt path rclone-test-goyafuj8pozi.bin: Auto set use_segments_container to true 2025/03/13 04:30:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-goyafuj8pozi" 2025/03/13 04:30:15 DEBUG : Swift container crypt path rclone-test-goyafuj8pozi: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe' -> Encrypted drive 'TestCryptSwift:rclone-test-goyafuj8pozi' 2025/03/13 04:30:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-goyafuj8pozi': Waiting for checks to finish 2025/03/13 04:30:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-goyafuj8pozi': Waiting for transfers to finish 2025/03/13 04:30:16 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:16 DEBUG : sub dir/hello world: md5 = 7e47068818c8928d351a9e7bd6ebc10b OK 2025/03/13 04:30:17 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/13 04:30:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-goyafuj8pozi': Waiting for checks to finish 2025/03/13 04:30:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-goyafuj8pozi': Waiting for transfers to finish 2025/03/13 04:30:17 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-goyafuj8pozi': Purge remote 2025/03/13 04:30:17 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:17 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (5.14s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:18 DEBUG : sub dir/hello world: md5 = 1cc20ed070765d899d1fa1f8c689079b OK 2025/03/13 04:30:19 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/13 04:30:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:19 DEBUG : sub dir/hello world: md5 = c4bbf66f471070d473a2386b959e934f OK 2025/03/13 04:30:19 INFO : sub dir/hello world: Copied (replaced existing) 2025/03/13 04:30:19 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestMoveOverSelf (1.60s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:20 DEBUG : sub dir/hello world: md5 = 6132a6c3b64b467df9be2437e8fe0325 OK 2025/03/13 04:30:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qivelos1mowo" 2025/03/13 04:30:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qivelos1mowo.bin" 2025/03/13 04:30:21 DEBUG : Swift container crypt path rclone-test-qivelos1mowo.bin: Auto set use_segments_container to true 2025/03/13 04:30:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qivelos1mowo" 2025/03/13 04:30:22 DEBUG : Swift container crypt path rclone-test-qivelos1mowo: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe' -> Encrypted drive 'TestCryptSwift:rclone-test-qivelos1mowo' 2025/03/13 04:30:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qivelos1mowo': Waiting for checks to finish 2025/03/13 04:30:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qivelos1mowo': Waiting for transfers to finish 2025/03/13 04:30:23 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:23 DEBUG : sub dir/hello world: md5 = 2fab1fcc0cbec4d0099bd01ab0b0599f OK 2025/03/13 04:30:24 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/03/13 04:30:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qivelos1mowo': Waiting for checks to finish 2025/03/13 04:30:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qivelos1mowo': Waiting for transfers to finish 2025/03/13 04:30:24 INFO : sub dir/hello world: Copied (server-side copy) 2025/03/13 04:30:24 INFO : sub dir/hello world: Deleted 2025/03/13 04:30:25 DEBUG : sub dir/hello world: md5 = 45a3781612ed4c62a4bf68fe5e8249cd OK 2025/03/13 04:30:25 DEBUG : testing file moves 2025/03/13 04:30:25 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/03/13 04:30:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qivelos1mowo': Waiting for checks to finish 2025/03/13 04:30:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qivelos1mowo': Waiting for transfers to finish 2025/03/13 04:30:25 INFO : sub dir/hello world: Copied (server-side copy) 2025/03/13 04:30:25 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qivelos1mowo': Purge remote 2025/03/13 04:30:26 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:26 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (6.52s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:27 DEBUG : sub dir/hello world: md5 = c39845803da5a10674cdbc54f412e36c OK 2025/03/13 04:30:27 ERROR : : error listing: directory not found 2025/03/13 04:30:27 INFO : Local file system at /tmp/rclone329930444: Making directory 2025/03/13 04:30:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyAfterDelete (1.40s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:28 DEBUG : sub dir/hello world: md5 = c5ae12e481e7dd5827d9234807551145 OK 2025/03/13 04:30:29 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:30:29 DEBUG : Local file system at /tmp/rclone329930444: Waiting for checks to finish 2025/03/13 04:30:29 DEBUG : Local file system at /tmp/rclone329930444: Waiting for transfers to finish 2025/03/13 04:30:29 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/03/13 04:30:29 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyRedownload (1.23s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:29 DEBUG : check sum: Need to transfer - File not found at Destination 2025/03/13 04:30:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:30 DEBUG : check sum: md5 = c065daf4aa13eab36671f1e1df70a5b4 OK 2025/03/13 04:30:30 INFO : check sum: Copied (new) 2025/03/13 04:30:30 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:30 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/03/13 04:30:30 DEBUG : check sum: Size of src and dst objects identical 2025/03/13 04:30:30 DEBUG : check sum: Unchanged skipping 2025/03/13 04:30:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:30 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:30 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (1.86s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:31 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/03/13 04:30:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:32 DEBUG : sizeonly: md5 = 9e6e923ddd17eb5e6df3a9371954fd45 OK 2025/03/13 04:30:32 INFO : sizeonly: Copied (new) 2025/03/13 04:30:32 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:32 DEBUG : sizeonly: Sizes identical 2025/03/13 04:30:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:32 DEBUG : sizeonly: Unchanged skipping 2025/03/13 04:30:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:32 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:32 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncSizeOnly (1.57s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:33 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/03/13 04:30:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:33 DEBUG : ignore-size: md5 = 8ea75979826668f362e4092f005b2632 OK 2025/03/13 04:30:33 INFO : ignore-size: Copied (new) 2025/03/13 04:30:33 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:33 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:30:33 DEBUG : ignore-size: Unchanged skipping 2025/03/13 04:30:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:33 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:33 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (2.14s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:35 DEBUG : existing: md5 = 1f8e5e0677910e97b8572a82fda44d0c OK 2025/03/13 04:30:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:35 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:30:35 DEBUG : existing: Unchanged skipping 2025/03/13 04:30:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:35 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:35 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:36 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/03/13 04:30:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:36 DEBUG : existing: md5 = f2ed92e19f10f7f7eef21aa98a5f3ee2 OK 2025/03/13 04:30:36 INFO : existing: Copied (replaced existing) 2025/03/13 04:30:36 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (2.60s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:37 DEBUG : existing: Need to transfer - File not found at Destination 2025/03/13 04:30:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:38 DEBUG : existing: md5 = e5997714119104ac51829da5a746e945 OK 2025/03/13 04:30:38 INFO : existing: Copied (new) 2025/03/13 04:30:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:38 DEBUG : existing: Destination exists, skipping 2025/03/13 04:30:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:38 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:38 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (1.56s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:39 DEBUG : b/potato: md5 = 7187bb97823771d94e2424f0e189fc93 OK 2025/03/13 04:30:40 DEBUG : c/non empty space: md5 = 839dd0fd93b72977ea0b8ff68cf1ba63 OK 2025/03/13 04:30:40 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/03/13 04:30:40 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/03/13 04:30:40 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:30:40 DEBUG : c/non empty space: Unchanged skipping 2025/03/13 04:30:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:41 DEBUG : a/potato2: md5 = 89015b6bb25c0e5c314b54486112a234 OK 2025/03/13 04:30:41 INFO : a/potato2: Copied (new) 2025/03/13 04:30:41 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:41 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (3.05s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:42 DEBUG : empty space: md5 = 34b08efa2b096aada3e83b219ed21ab1 OK 2025/03/13 04:30:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:43 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/03/13 04:30:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:43 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/03/13 04:30:43 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:43 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/03/13 04:30:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:43 DEBUG : empty space: md5 = efcd2fca70cca44b59eb69001d9f1b61 OK 2025/03/13 04:30:43 INFO : empty space: Copied (replaced existing) 2025/03/13 04:30:43 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (2.17s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:1016: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.10s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:44 DEBUG : foo: md5 = 29076db7fcaff7ad18753afaa8ee2a75 OK 2025/03/13 04:30:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:45 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/03/13 04:30:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:45 DEBUG : foo: md5 = 5ee2fb409e3ab09adf4d8aba64ee346e OK 2025/03/13 04:30:45 INFO : foo: Copied (replaced existing) 2025/03/13 04:30:45 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (1.56s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:46 DEBUG : empty space: md5 = 8650010c5a59ae531f57c750baf96ea2 OK 2025/03/13 04:30:46 DEBUG : potato: Need to transfer - File not found at Destination 2025/03/13 04:30:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:46 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:30:46 DEBUG : empty space: Unchanged skipping 2025/03/13 04:30:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:47 DEBUG : potato: md5 = 770d24d5283758abac342f1fa7c1cda6 OK 2025/03/13 04:30:47 INFO : potato: Copied (new) 2025/03/13 04:30:47 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (1.74s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:48 DEBUG : potato: md5 = 1830d67a382025e02ff48dced5e4b729 OK 2025/03/13 04:30:48 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/03/13 04:30:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:48 DEBUG : potato: md5 = 56f8e538ea12c09631cbeec51774a31c OK 2025/03/13 04:30:48 INFO : potato: Copied (replaced existing) 2025/03/13 04:30:48 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (2.31s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:50 DEBUG : potato: md5 = 8264b496a271eac5347de4d75a3ffb7a OK 2025/03/13 04:30:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:50 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2025/03/13 04:30:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:51 DEBUG : potato: md5 = 3ed76a8efca9ee60cdf8de73fb315b55 OK 2025/03/13 04:30:51 INFO : potato: Copied (replaced existing) 2025/03/13 04:30:51 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (1.88s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:52 DEBUG : potato: md5 = 9867b343b626fc71a74f60375f89edb4 OK 2025/03/13 04:30:52 DEBUG : empty space: md5 = affcb26202ed638211f14aecf505dc99 OK 2025/03/13 04:30:52 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:30:52 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/03/13 04:30:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:52 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:30:52 DEBUG : empty space: Unchanged skipping 2025/03/13 04:30:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:52 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:52 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (1.48s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:53 DEBUG : potato: md5 = 54e514df8fd428167efb33515953bd11 OK 2025/03/13 04:30:53 DEBUG : empty space: md5 = a34eee46826e0713290969c5a5ab3ee5 OK 2025/03/13 04:30:54 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:30:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:54 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:30:54 DEBUG : empty space: Unchanged skipping 2025/03/13 04:30:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:54 DEBUG : potato2: md5 = 9b06946cf76f8d2cfe4f102f480bd54f OK 2025/03/13 04:30:54 INFO : potato2: Copied (new) 2025/03/13 04:30:54 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:54 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.03s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:55 DEBUG : b/potato: md5 = 3d3d68c7ef66368bddd6c55d9f7689a9 OK 2025/03/13 04:30:55 DEBUG : c/non empty space: md5 = f973987d55cf7c5cbffaadb6d5e97d30 OK 2025/03/13 04:30:55 INFO : d: Making directory 2025/03/13 04:30:55 INFO : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2025/03/13 04:30:56 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/03/13 04:30:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:56 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:30:56 DEBUG : c/non empty space: Unchanged skipping 2025/03/13 04:30:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:56 DEBUG : a/potato2: md5 = 5be8bb210a68d8bbbb6aca3849f23e37 OK 2025/03/13 04:30:56 INFO : a/potato2: Copied (new) 2025/03/13 04:30:56 DEBUG : Waiting for deletions to finish 2025/03/13 04:30:56 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (2.64s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:30:58 DEBUG : b/potato: md5 = e08d0fc3e7db8590b0c2516937272f8f OK 2025/03/13 04:30:58 DEBUG : c/non empty space: md5 = c67b6eb78439a350423b72bab89688e2 OK 2025/03/13 04:30:58 INFO : d: Making directory fstest.go:244: Filtering empty directory "d" 2025/03/13 04:30:58 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/03/13 04:30:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:30:58 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:30:58 DEBUG : c/non empty space: Unchanged skipping 2025/03/13 04:30:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:30:59 DEBUG : a/potato2: md5 = a775065dd01a0eccd40a7ce5e6e44756 OK 2025/03/13 04:30:59 INFO : a/potato2: Copied (new) 2025/03/13 04:30:59 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': not deleting files as there were IO errors 2025/03/13 04:30:59 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (2.10s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:00 DEBUG : potato: md5 = 5407cba836c0a0dc929bddd6e4ec31b6 OK 2025/03/13 04:31:00 DEBUG : empty space: md5 = 6ff27cb8a4a5e4cd90c4bef4c5697b10 OK 2025/03/13 04:31:01 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:01 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:31:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:01 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:01 DEBUG : empty space: Unchanged skipping 2025/03/13 04:31:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:01 INFO : potato: Deleted 2025/03/13 04:31:01 DEBUG : potato2: md5 = 9fcedf6e3889b15cda06774f4efeab39 OK 2025/03/13 04:31:01 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (2.03s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:02 DEBUG : potato: md5 = 89a9a57a9b5affbded206df25afc129d OK 2025/03/13 04:31:02 DEBUG : empty space: md5 = 8c3dce3a0098288e51ce1110dcc0a7ee OK 2025/03/13 04:31:02 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:03 INFO : potato: Deleted 2025/03/13 04:31:03 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:31:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:03 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:03 DEBUG : empty space: Unchanged skipping 2025/03/13 04:31:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:03 DEBUG : potato2: md5 = a382d8fb1061bf31e05e18c60395bfe3 OK 2025/03/13 04:31:03 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (1.97s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:04 DEBUG : potato: md5 = d3d70cd8debfbc90096b57cd7a97fa55 OK 2025/03/13 04:31:04 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:31:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:04 DEBUG : potato2: md5 = 037f62bd37d5845043f3f4777514e298 OK 2025/03/13 04:31:04 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (1.58s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:06 DEBUG : potato2: md5 = 68576ce2a801177d9c3472568fcb1535 OK 2025/03/13 04:31:06 DEBUG : empty space: md5 = 30082c8b3f2df73f9147000f6bc4aedd OK 2025/03/13 04:31:06 DEBUG : enormous: Excluded (Size Filter) 2025/03/13 04:31:06 DEBUG : enormous: Excluded 2025/03/13 04:31:06 DEBUG : potato2: Excluded (Size Filter) 2025/03/13 04:31:06 DEBUG : potato2: Excluded 2025/03/13 04:31:06 DEBUG : potato2: Excluded (Size Filter) 2025/03/13 04:31:06 DEBUG : potato2: Excluded 2025/03/13 04:31:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:06 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:06 DEBUG : empty space: Unchanged skipping 2025/03/13 04:31:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:06 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:06 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:06 DEBUG : enormous: Excluded (Size Filter) 2025/03/13 04:31:06 DEBUG : enormous: Excluded 2025/03/13 04:31:06 DEBUG : potato2: Excluded (Size Filter) 2025/03/13 04:31:06 DEBUG : potato2: Excluded 2025/03/13 04:31:07 DEBUG : potato2: Excluded (Size Filter) 2025/03/13 04:31:07 DEBUG : potato2: Excluded 2025/03/13 04:31:07 DEBUG : Local file system at /tmp/rclone329930444: Waiting for checks to finish 2025/03/13 04:31:07 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:07 DEBUG : empty space: Unchanged skipping 2025/03/13 04:31:07 DEBUG : Local file system at /tmp/rclone329930444: Waiting for transfers to finish 2025/03/13 04:31:07 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:07 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncWithExclude (2.13s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:08 DEBUG : potato2: md5 = 75aed269e5db7f7e2da8c0a1e7cda9d6 OK 2025/03/13 04:31:08 DEBUG : empty space: md5 = f04cf7c725c476741e356b0d277f0a97 OK 2025/03/13 04:31:08 DEBUG : enormous: md5 = c51e8e88d5bc68e518c4ca95a908b5f7 OK 2025/03/13 04:31:09 DEBUG : enormous: Excluded (Size Filter) 2025/03/13 04:31:09 DEBUG : enormous: Excluded 2025/03/13 04:31:09 DEBUG : potato2: Excluded (Size Filter) 2025/03/13 04:31:09 DEBUG : potato2: Excluded 2025/03/13 04:31:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:09 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:09 DEBUG : empty space: Unchanged skipping 2025/03/13 04:31:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:09 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:09 INFO : potato2: Deleted 2025/03/13 04:31:09 INFO : enormous: Deleted 2025/03/13 04:31:09 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:09 DEBUG : Local file system at /tmp/rclone329930444: Waiting for checks to finish 2025/03/13 04:31:09 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:09 DEBUG : empty space: Unchanged skipping 2025/03/13 04:31:09 DEBUG : Local file system at /tmp/rclone329930444: Waiting for transfers to finish 2025/03/13 04:31:09 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:09 INFO : enormous: Deleted 2025/03/13 04:31:09 INFO : potato2: Deleted 2025/03/13 04:31:09 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (2.28s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:10 DEBUG : one: md5 = 39bd0d79d22177907c13575561daf1db OK 2025/03/13 04:31:10 DEBUG : two: md5 = 1c3fabc405b0134eb24f1dadf4c736fa OK 2025/03/13 04:31:11 DEBUG : three: md5 = a19aa5a07063795a5b98c224fe641179 OK 2025/03/13 04:31:11 DEBUG : four: md5 = b8c89e9a5fca2d92b77668d0484b09f5 OK 2025/03/13 04:31:12 DEBUG : five: Need to transfer - File not found at Destination 2025/03/13 04:31:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:12 DEBUG : one: Destination is newer than source, skipping 2025/03/13 04:31:12 DEBUG : three: Sizes identical 2025/03/13 04:31:12 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/03/13 04:31:12 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/03/13 04:31:12 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/03/13 04:31:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:12 DEBUG : four: md5 = 47a64cc0cead7afce876a4dbcea3f6d6 OK 2025/03/13 04:31:12 INFO : four: Copied (replaced existing) 2025/03/13 04:31:12 DEBUG : two: md5 = 46d2451f2098184f4ff29cda76eb0c42 OK 2025/03/13 04:31:12 INFO : two: Copied (replaced existing) 2025/03/13 04:31:12 DEBUG : five: md5 = 3fff9a8e7ffe8d7d9aa9bf11b52e9ff6 OK 2025/03/13 04:31:12 INFO : five: Copied (new) 2025/03/13 04:31:12 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (3.45s) === 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-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2025/03/13 04:31:13 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Ignoring --track-renames as the source and destination do not have a common hash 2025/03/13 04:31:13 DEBUG : potato: Need to transfer - File not found at Destination 2025/03/13 04:31:13 DEBUG : yam: Need to transfer - File not found at Destination 2025/03/13 04:31:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:14 DEBUG : potato: md5 = d4146e8cfe43cdc576c69036437c8ae6 OK 2025/03/13 04:31:14 INFO : potato: Copied (new) 2025/03/13 04:31:14 DEBUG : yam: md5 = 4e982a3f9ffd6eee9efd15ec3efb4125 OK 2025/03/13 04:31:14 INFO : yam: Copied (new) 2025/03/13 04:31:14 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:14 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Ignoring --track-renames as the source and destination do not have a common hash 2025/03/13 04:31:14 DEBUG : yaml: Need to transfer - File not found at Destination 2025/03/13 04:31:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:14 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:14 DEBUG : potato: Unchanged skipping 2025/03/13 04:31:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:14 DEBUG : yaml: md5 = 6ff6527b6ec4d0dfb58af8859f5c838d OK 2025/03/13 04:31:14 INFO : yaml: Copied (new) 2025/03/13 04:31:14 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:15 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (2.55s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2025/03/13 04:31:16 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Making map for --track-renames 2025/03/13 04:31:16 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Finished making map for --track-renames 2025/03/13 04:31:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:16 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/13 04:31:16 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/03/13 04:31:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for renames to finish 2025/03/13 04:31:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:16 DEBUG : potato: md5 = 7ecb06d9355a7a07f49fd8ea3091d683 OK 2025/03/13 04:31:16 INFO : potato: Copied (new) 2025/03/13 04:31:16 DEBUG : yam: md5 = 118cc13966c04a02e2354498c56ac36d OK 2025/03/13 04:31:16 INFO : yam: Copied (new) 2025/03/13 04:31:16 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:16 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Making map for --track-renames 2025/03/13 04:31:16 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Finished making map for --track-renames 2025/03/13 04:31:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:16 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:16 DEBUG : potato: Unchanged skipping 2025/03/13 04:31:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for renames to finish 2025/03/13 04:31:17 INFO : yam: Copied (server-side copy) to: yaml 2025/03/13 04:31:17 INFO : yam: Deleted 2025/03/13 04:31:17 INFO : yaml: Renamed from "yam" 2025/03/13 04:31:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:17 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (2.07s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2025/03/13 04:31:18 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Making map for --track-renames 2025/03/13 04:31:18 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Finished making map for --track-renames 2025/03/13 04:31:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:18 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/03/13 04:31:18 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/03/13 04:31:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for renames to finish 2025/03/13 04:31:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:18 DEBUG : potato: md5 = d6089934513b6bd43d873ff2bb739078 OK 2025/03/13 04:31:18 INFO : potato: Copied (new) 2025/03/13 04:31:18 DEBUG : sub/yam: md5 = 5e8bf5f8dbbf722faf819030cfe88370 OK 2025/03/13 04:31:18 INFO : sub/yam: Copied (new) 2025/03/13 04:31:18 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:19 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:19 DEBUG : potato: Unchanged skipping 2025/03/13 04:31:19 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Making map for --track-renames 2025/03/13 04:31:19 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Finished making map for --track-renames 2025/03/13 04:31:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for renames to finish 2025/03/13 04:31:19 INFO : sub/yam: Copied (server-side copy) to: yam 2025/03/13 04:31:19 INFO : sub/yam: Deleted 2025/03/13 04:31:19 INFO : yam: Renamed from "sub/yam" 2025/03/13 04:31:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:19 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (2.67s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:21 DEBUG : Creating backend with remote "/tmp/rclone329930444/dir1" 2025/03/13 04:31:21 DEBUG : Creating backend with remote "/tmp/rclone329930444/dir2" 2025/03/13 04:31:21 DEBUG : Local file system at /tmp/rclone329930444/dir2: Using server-side directory move 2025/03/13 04:31:21 INFO : Local file system at /tmp/rclone329930444/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/03/13 04:31:21 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/03/13 04:31:21 INFO : file1.txt: Moved (server-side) 2025/03/13 04:31:21 DEBUG : Local file system at /tmp/rclone329930444/dir2: Waiting for checks to finish 2025/03/13 04:31:21 DEBUG : Local file system at /tmp/rclone329930444/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.10s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:31:21 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/03/13 04:31:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:21 DEBUG : sub dir/hello world: md5 = f329e4553af493d49bc0d8e9820e8157 OK 2025/03/13 04:31:21 INFO : sub dir/hello world: Copied (new) 2025/03/13 04:31:21 INFO : sub dir/hello world: Deleted 2025/03/13 04:31:21 DEBUG : nested/sub dir/file: md5 = 2c7fa451d5acf77d8a93728c05ba8646 OK 2025/03/13 04:31:21 INFO : nested/sub dir/file: Copied (new) 2025/03/13 04:31:21 INFO : nested/sub dir/file: Deleted 2025/03/13 04:31:21 INFO : sub dir: Removing directory 2025/03/13 04:31:21 INFO : nested/sub dir: Removing directory 2025/03/13 04:31:21 INFO : nested: Removing directory 2025/03/13 04:31:21 DEBUG : Local file system at /tmp/rclone329930444: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (1.70s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/03/13 04:31:22 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/03/13 04:31:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:23 DEBUG : sub dir/hello world: md5 = cdf9a1bc431389c9b6e9de81494df143 OK 2025/03/13 04:31:23 INFO : sub dir/hello world: Copied (new) 2025/03/13 04:31:23 INFO : sub dir/hello world: Deleted 2025/03/13 04:31:23 DEBUG : nested/sub dir/file: md5 = c0c301eb2caff607398b0fceb3ecb92c OK 2025/03/13 04:31:23 INFO : nested/sub dir/file: Copied (new) 2025/03/13 04:31:23 INFO : nested/sub dir/file: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (1.28s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:24 DEBUG : existing: Need to transfer - File not found at Destination 2025/03/13 04:31:24 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/03/13 04:31:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:24 DEBUG : existing: md5 = b867d565a12a79669f568500ab9e0723 OK 2025/03/13 04:31:24 INFO : existing: Copied (new) 2025/03/13 04:31:24 INFO : existing: Deleted 2025/03/13 04:31:24 DEBUG : existing-b: md5 = 327693d41dae94006af2c59f087d6913 OK 2025/03/13 04:31:24 INFO : existing-b: Copied (new) 2025/03/13 04:31:24 INFO : existing-b: Deleted 2025/03/13 04:31:25 DEBUG : existing: Destination exists, skipping 2025/03/13 04:31:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:31:25 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/03/13 04:31:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:31:25 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (2.11s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-vinataq1gigi" 2025/03/13 04:31:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-vinataq1gigi.bin" 2025/03/13 04:31:26 DEBUG : Swift container crypt path rclone-test-vinataq1gigi.bin: Auto set use_segments_container to true 2025/03/13 04:31:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-vinataq1gigi" 2025/03/13 04:31:27 DEBUG : Swift container crypt path rclone-test-vinataq1gigi: Auto set use_segments_container to true 2025/03/13 04:31:28 DEBUG : potato2: md5 = aa5f0283a0ba66b59bdb976af84bf3d5 OK 2025/03/13 04:31:28 DEBUG : empty space: md5 = 857cb1696dc575b7841b51338e248e22 OK 2025/03/13 04:31:28 DEBUG : potato3: md5 = 3c69c6bf6c33b348b684e33ce8180d4f OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe' -> Encrypted drive 'TestCryptSwift:rclone-test-vinataq1gigi' 2025/03/13 04:31:29 DEBUG : empty space: md5 = aab061134bd5c8205f11e95e92200621 OK 2025/03/13 04:31:30 DEBUG : potato3: md5 = b0cc9f26d973f28f3a954d54668ba478 OK 2025/03/13 04:31:30 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:31:30 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/13 04:31:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vinataq1gigi': Waiting for checks to finish 2025/03/13 04:31:31 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:31 DEBUG : empty space: Unchanged skipping 2025/03/13 04:31:31 INFO : empty space: Deleted 2025/03/13 04:31:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vinataq1gigi': Waiting for transfers to finish 2025/03/13 04:31:31 INFO : potato2: Copied (server-side copy) 2025/03/13 04:31:31 INFO : potato3: Copied (server-side copy) 2025/03/13 04:31:31 INFO : potato3: Deleted 2025/03/13 04:31:31 INFO : potato2: Deleted 2025/03/13 04:31:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-vowuwuw1quhu" 2025/03/13 04:31:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-vowuwuw1quhu.bin" 2025/03/13 04:31:32 DEBUG : Swift container crypt path rclone-test-vowuwuw1quhu.bin: Auto set use_segments_container to true 2025/03/13 04:31:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-vowuwuw1quhu" 2025/03/13 04:31:33 DEBUG : Swift container crypt path rclone-test-vowuwuw1quhu: Auto set use_segments_container to true 2025/03/13 04:31:34 DEBUG : empty space: Need to transfer - File not found at Destination 2025/03/13 04:31:34 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:31:34 DEBUG : potato3: Need to transfer - File not found at Destination 2025/03/13 04:31:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vowuwuw1quhu': Waiting for checks to finish 2025/03/13 04:31:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vowuwuw1quhu': Waiting for transfers to finish 2025/03/13 04:31:34 INFO : empty space: Copied (server-side copy) 2025/03/13 04:31:34 INFO : empty space: Deleted 2025/03/13 04:31:34 INFO : potato2: Copied (server-side copy) 2025/03/13 04:31:34 INFO : potato3: Copied (server-side copy) 2025/03/13 04:31:34 INFO : potato2: Deleted 2025/03/13 04:31:35 INFO : potato3: Deleted 2025/03/13 04:31:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vowuwuw1quhu': Purge remote 2025/03/13 04:31:35 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:35 INFO : empty space.bin: Deleted 2025/03/13 04:31:35 INFO : potato3.bin: Deleted 2025/03/13 04:31:37 INFO : potato2.bin: Deleted 2025/03/13 04:31:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-vinataq1gigi': Purge remote 2025/03/13 04:31:37 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (11.40s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-pimasag4wuro" 2025/03/13 04:31:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pimasag4wuro.bin" 2025/03/13 04:31:38 DEBUG : Swift container crypt path rclone-test-pimasag4wuro.bin: Auto set use_segments_container to true 2025/03/13 04:31:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pimasag4wuro" 2025/03/13 04:31:39 DEBUG : Swift container crypt path rclone-test-pimasag4wuro: Auto set use_segments_container to true 2025/03/13 04:31:39 DEBUG : potato2: md5 = 153e4f03b18611e44dbfdfe7d5973e80 OK 2025/03/13 04:31:39 DEBUG : empty space: md5 = d6dfa499c23690202abbc47dc500ee9c OK 2025/03/13 04:31:39 DEBUG : potato3: md5 = e03f097c0ccf8a95182742b616ce05dc OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe' -> Encrypted drive 'TestCryptSwift:rclone-test-pimasag4wuro' 2025/03/13 04:31:41 DEBUG : empty space: md5 = b53e0274e898333e9d5df375b6465c1e OK 2025/03/13 04:31:41 DEBUG : potato3: md5 = 6ba73330ee224858319a5f509a022d41 OK 2025/03/13 04:31:42 DEBUG : empty space: Excluded (Size Filter) 2025/03/13 04:31:42 DEBUG : empty space: Excluded 2025/03/13 04:31:42 DEBUG : empty space: Excluded (Size Filter) 2025/03/13 04:31:42 DEBUG : empty space: Excluded 2025/03/13 04:31:42 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:31:42 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/13 04:31:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pimasag4wuro': Waiting for checks to finish 2025/03/13 04:31:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pimasag4wuro': Waiting for transfers to finish 2025/03/13 04:31:42 INFO : potato3: Copied (server-side copy) 2025/03/13 04:31:42 INFO : potato3: Deleted 2025/03/13 04:31:42 INFO : potato2: Copied (server-side copy) 2025/03/13 04:31:43 INFO : potato2: Deleted 2025/03/13 04:31:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-heleham2cuve" 2025/03/13 04:31:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-heleham2cuve.bin" 2025/03/13 04:31:44 DEBUG : Swift container crypt path rclone-test-heleham2cuve.bin: Auto set use_segments_container to true 2025/03/13 04:31:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-heleham2cuve" 2025/03/13 04:31:45 DEBUG : Swift container crypt path rclone-test-heleham2cuve: Auto set use_segments_container to true 2025/03/13 04:31:45 DEBUG : empty space: Excluded (Size Filter) 2025/03/13 04:31:45 DEBUG : empty space: Excluded 2025/03/13 04:31:45 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:31:45 DEBUG : potato3: Need to transfer - File not found at Destination 2025/03/13 04:31:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-heleham2cuve': Waiting for checks to finish 2025/03/13 04:31:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-heleham2cuve': Waiting for transfers to finish 2025/03/13 04:31:46 INFO : potato3: Copied (server-side copy) 2025/03/13 04:31:46 INFO : potato2: Copied (server-side copy) 2025/03/13 04:31:46 INFO : potato2: Deleted 2025/03/13 04:31:46 INFO : potato3: Deleted 2025/03/13 04:31:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-heleham2cuve': Purge remote 2025/03/13 04:31:47 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:47 INFO : potato2.bin: Deleted 2025/03/13 04:31:47 INFO : potato3.bin: Deleted 2025/03/13 04:31:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pimasag4wuro': Purge remote 2025/03/13 04:31:47 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:47 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (10.58s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yayayir1zequ" 2025/03/13 04:31:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yayayir1zequ.bin" 2025/03/13 04:31:48 DEBUG : Swift container crypt path rclone-test-yayayir1zequ.bin: Auto set use_segments_container to true 2025/03/13 04:31:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yayayir1zequ" 2025/03/13 04:31:49 DEBUG : Swift container crypt path rclone-test-yayayir1zequ: Auto set use_segments_container to true 2025/03/13 04:31:50 DEBUG : potato2: md5 = 6fa196bdeac632a81cee1133fe9cc6a6 OK 2025/03/13 04:31:50 DEBUG : empty space: md5 = 547181d318e25b6544185125767e682b OK 2025/03/13 04:31:50 DEBUG : potato3: md5 = 8b0aaeb4e0f5e556737a7fa18d3a645f OK 2025/03/13 04:31:50 INFO : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe' -> Encrypted drive 'TestCryptSwift:rclone-test-yayayir1zequ' 2025/03/13 04:31:51 DEBUG : empty space: md5 = 4ec18dfb413fb8d371369ba5266b39db OK 2025/03/13 04:31:52 DEBUG : potato3: md5 = a401354a409abcdcc2776fe3d69f354a OK 2025/03/13 04:31:52 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:31:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yayayir1zequ': Waiting for checks to finish 2025/03/13 04:31:52 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/03/13 04:31:52 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:31:52 DEBUG : empty space: Unchanged skipping 2025/03/13 04:31:52 INFO : empty space: Deleted 2025/03/13 04:31:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yayayir1zequ': Waiting for transfers to finish 2025/03/13 04:31:52 INFO : potato3: Copied (server-side copy) 2025/03/13 04:31:53 INFO : potato3: Deleted 2025/03/13 04:31:53 INFO : potato2: Copied (server-side copy) 2025/03/13 04:31:53 INFO : potato2: Deleted 2025/03/13 04:31:54 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wiqedap3goto" 2025/03/13 04:31:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiqedap3goto.bin" 2025/03/13 04:31:54 DEBUG : Swift container crypt path rclone-test-wiqedap3goto.bin: Auto set use_segments_container to true 2025/03/13 04:31:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wiqedap3goto" 2025/03/13 04:31:55 DEBUG : Swift container crypt path rclone-test-wiqedap3goto: Auto set use_segments_container to true 2025/03/13 04:31:56 INFO : tomatoDir: Making directory 2025/03/13 04:31:56 DEBUG : empty space: Need to transfer - File not found at Destination 2025/03/13 04:31:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/03/13 04:31:56 DEBUG : potato3: Need to transfer - File not found at Destination 2025/03/13 04:31:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiqedap3goto': Waiting for checks to finish 2025/03/13 04:31:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiqedap3goto': Waiting for transfers to finish 2025/03/13 04:31:57 INFO : potato2: Copied (server-side copy) 2025/03/13 04:31:57 INFO : potato3: Copied (server-side copy) 2025/03/13 04:31:57 INFO : empty space: Copied (server-side copy) 2025/03/13 04:31:57 INFO : potato2: Deleted 2025/03/13 04:31:57 INFO : potato3: Deleted 2025/03/13 04:31:57 INFO : empty space: Deleted 2025/03/13 04:31:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wiqedap3goto': Purge remote 2025/03/13 04:31:57 DEBUG : Waiting for deletions to finish 2025/03/13 04:31:58 INFO : potato2.bin: Deleted 2025/03/13 04:31:58 INFO : potato3.bin: Deleted 2025/03/13 04:31:58 INFO : empty space.bin: Deleted 2025/03/13 04:31:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yayayir1zequ': Purge remote 2025/03/13 04:31:58 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (10.35s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:31:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/rclone-move-test" 2025/03/13 04:31:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-move-test.bin" 2025/03/13 04:31:59 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-move-test.bin: Auto set use_segments_container to true 2025/03/13 04:31:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-move-test" 2025/03/13 04:32:00 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-move-test: Auto set use_segments_container to true 2025/03/13 04:32:00 DEBUG : potato2: md5 = d36a7db0b9ae02157dbe980eb96201f4 OK --- PASS: TestServerSideMoveOverlap (2.81s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:32:01 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test" 2025/03/13 04:32:01 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-sync-test.bin" 2025/03/13 04:32:02 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-sync-test.bin: Auto set use_segments_container to true 2025/03/13 04:32:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-sync-test" 2025/03/13 04:32:03 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncOverlap (2.67s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:32:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test" 2025/03/13 04:32:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-sync-test.bin" 2025/03/13 04:32:04 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-sync-test.bin: Auto set use_segments_container to true 2025/03/13 04:32:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-sync-test" 2025/03/13 04:32:05 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-sync-test: Auto set use_segments_container to true 2025/03/13 04:32:05 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test-include/layer2" 2025/03/13 04:32:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-sync-test-include/layer2.bin" 2025/03/13 04:32:06 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/03/13 04:32:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-sync-test-include/layer2" 2025/03/13 04:32:06 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/03/13 04:32:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test-ignore-file" 2025/03/13 04:32:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-sync-test-ignore-file.bin" 2025/03/13 04:32:07 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/03/13 04:32:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/rclone-sync-test-ignore-file" 2025/03/13 04:32:08 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/03/13 04:32:09 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = d1f5e9c993b38476dec3c4d071cd2401 OK 2025/03/13 04:32:09 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/13 04:32:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test': Waiting for checks to finish 2025/03/13 04:32:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test': Waiting for transfers to finish 2025/03/13 04:32:09 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:09 INFO : There was nothing to transfer 2025/03/13 04:32:10 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/13 04:32:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:32:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:32:10 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:10 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:32:10 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/13 04:32:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/03/13 04:32:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/03/13 04:32:10 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:10 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:32:10 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/13 04:32:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:32:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:32:10 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:10 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:32:10 DEBUG : : Excluded 2025/03/13 04:32:10 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/03/13 04:32:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/03/13 04:32:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/03/13 04:32:10 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:10 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (9.93s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:32:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/dst" 2025/03/13 04:32:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst.bin" 2025/03/13 04:32:14 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst.bin: Auto set use_segments_container to true 2025/03/13 04:32:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst" 2025/03/13 04:32:15 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst: Auto set use_segments_container to true 2025/03/13 04:32:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/CompareDest" 2025/03/13 04:32:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/CompareDest.bin" 2025/03/13 04:32:16 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/CompareDest.bin: Auto set use_segments_container to true 2025/03/13 04:32:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/CompareDest" 2025/03/13 04:32:17 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/CompareDest: Auto set use_segments_container to true 2025/03/13 04:32:18 DEBUG : one: Need to transfer - File not found at Destination 2025/03/13 04:32:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:18 DEBUG : one: md5 = e846065e99ac013be929d2356c399465 OK 2025/03/13 04:32:18 INFO : one: Copied (new) 2025/03/13 04:32:18 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:18 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/13 04:32:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:19 DEBUG : one: md5 = d04f0c3680be136ddbc602e3345fc915 OK 2025/03/13 04:32:19 INFO : one: Copied (replaced existing) 2025/03/13 04:32:19 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:19 DEBUG : dst/one: md5 = dc038429a1d9afe757b9889ff16138c6 OK 2025/03/13 04:32:20 DEBUG : CompareDest/one: md5 = ed351163459ceb433e6b596d5dbde012 OK 2025/03/13 04:32:20 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/13 04:32:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:20 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:20 DEBUG : one: Destination found in --compare-dest, skipping 2025/03/13 04:32:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:20 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:20 INFO : There was nothing to transfer 2025/03/13 04:32:21 DEBUG : CompareDest/two: md5 = ebfb8c27bb8ee8c90490b90c10523ee2 OK 2025/03/13 04:32:22 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:22 DEBUG : two: Destination found in --compare-dest, skipping 2025/03/13 04:32:22 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/13 04:32:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:22 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:22 DEBUG : one: Destination found in --compare-dest, skipping 2025/03/13 04:32:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:22 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:22 INFO : There was nothing to transfer 2025/03/13 04:32:22 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:22 DEBUG : two: Destination found in --compare-dest, skipping 2025/03/13 04:32:22 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/13 04:32:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:22 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:22 DEBUG : one: Destination found in --compare-dest, skipping 2025/03/13 04:32:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:22 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:22 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2025/03/13 04:32:23 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/03/13 04:32:23 DEBUG : two: Need to transfer - File not found at Destination 2025/03/13 04:32:23 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/13 04:32:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:23 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:23 DEBUG : one: Destination found in --compare-dest, skipping 2025/03/13 04:32:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:25 DEBUG : two: md5 = 984329d398a4d6aba216cecb1f866bfe OK 2025/03/13 04:32:25 INFO : two: Copied (new) 2025/03/13 04:32:25 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (12.68s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:32:27 DEBUG : pre-dest1/1: md5 = a74564d605fa302a7f7713c1a97978df OK 2025/03/13 04:32:28 DEBUG : pre-dest2/2: md5 = 12a11b1c4fe07cb651ec39c780a85036 OK 2025/03/13 04:32:29 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/dest" 2025/03/13 04:32:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dest.bin" 2025/03/13 04:32:29 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dest.bin: Auto set use_segments_container to true 2025/03/13 04:32:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dest" 2025/03/13 04:32:30 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dest: Auto set use_segments_container to true 2025/03/13 04:32:30 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/pre-dest1" 2025/03/13 04:32:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/pre-dest1.bin" 2025/03/13 04:32:31 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/pre-dest1.bin: Auto set use_segments_container to true 2025/03/13 04:32:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/pre-dest1" 2025/03/13 04:32:32 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/pre-dest1: Auto set use_segments_container to true 2025/03/13 04:32:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/pre-dest2" 2025/03/13 04:32:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/pre-dest2.bin" 2025/03/13 04:32:33 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/pre-dest2.bin: Auto set use_segments_container to true 2025/03/13 04:32:33 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/pre-dest2" 2025/03/13 04:32:34 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/pre-dest2: Auto set use_segments_container to true 2025/03/13 04:32:34 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:34 DEBUG : 1: Destination found in --compare-dest, skipping 2025/03/13 04:32:34 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:34 DEBUG : 2: Destination found in --compare-dest, skipping 2025/03/13 04:32:35 DEBUG : 3: Need to transfer - File not found at Destination 2025/03/13 04:32:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dest': Waiting for checks to finish 2025/03/13 04:32:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dest': Waiting for transfers to finish 2025/03/13 04:32:36 DEBUG : 3: md5 = f77131cb3547bf6766207c3093f69165 OK 2025/03/13 04:32:36 INFO : 3: Copied (new) 2025/03/13 04:32:36 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (11.94s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:32:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/dst" 2025/03/13 04:32:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst.bin" 2025/03/13 04:32:39 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst.bin: Auto set use_segments_container to true 2025/03/13 04:32:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst" 2025/03/13 04:32:40 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst: Auto set use_segments_container to true 2025/03/13 04:32:40 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/CopyDest" 2025/03/13 04:32:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/CopyDest.bin" 2025/03/13 04:32:40 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/CopyDest.bin: Auto set use_segments_container to true 2025/03/13 04:32:41 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/CopyDest" 2025/03/13 04:32:41 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/CopyDest: Auto set use_segments_container to true 2025/03/13 04:32:42 DEBUG : one: Need to transfer - File not found at Destination 2025/03/13 04:32:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:42 DEBUG : one: md5 = 761bb915e707862ac9363c77306aaffc OK 2025/03/13 04:32:42 INFO : one: Copied (new) 2025/03/13 04:32:42 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:42 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/13 04:32:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:43 DEBUG : one: md5 = a12b94c14df5961c41c919f74a8174de OK 2025/03/13 04:32:43 INFO : one: Copied (replaced existing) 2025/03/13 04:32:43 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:43 DEBUG : dst/one: md5 = 996a6fabc1ca839a26c1356f18d034b7 OK 2025/03/13 04:32:43 DEBUG : CopyDest/one: md5 = 99ef14cb139612edef434a97bad71b9f OK 2025/03/13 04:32:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/BackupDir" 2025/03/13 04:32:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/BackupDir.bin" 2025/03/13 04:32:44 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/BackupDir.bin: Auto set use_segments_container to true 2025/03/13 04:32:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/BackupDir" 2025/03/13 04:32:45 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/BackupDir: Auto set use_segments_container to true 2025/03/13 04:32:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:45 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/13 04:32:45 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:45 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/13 04:32:46 INFO : one: Copied (server-side copy) 2025/03/13 04:32:47 INFO : one: Deleted 2025/03/13 04:32:47 INFO : one: Copied (server-side copy) 2025/03/13 04:32:47 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/03/13 04:32:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:47 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:47 DEBUG : CopyDest/two: md5 = 6cc04843cd504362eb225d0f116875a6 OK 2025/03/13 04:32:48 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:48 INFO : two: Copied (server-side copy) 2025/03/13 04:32:48 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/03/13 04:32:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:48 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:48 DEBUG : one: Unchanged skipping 2025/03/13 04:32:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:48 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:49 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:49 DEBUG : two: Unchanged skipping 2025/03/13 04:32:49 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:49 DEBUG : one: Unchanged skipping 2025/03/13 04:32:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:49 DEBUG : Waiting for deletions to finish 2025/03/13 04:32:49 INFO : There was nothing to transfer 2025/03/13 04:32:50 DEBUG : CopyDest/three: md5 = 9ba7247aea7014e80883d0593d129f3e OK 2025/03/13 04:32:50 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/03/13 04:32:50 DEBUG : three: Destination not found in --copy-dest 2025/03/13 04:32:50 DEBUG : three: Need to transfer - File not found at Destination 2025/03/13 04:32:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:50 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:50 DEBUG : one: Unchanged skipping 2025/03/13 04:32:51 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:51 DEBUG : two: Unchanged skipping 2025/03/13 04:32:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:32:51 DEBUG : three: md5 = 76e906c7cb2cafea781beb4369ff3296 OK 2025/03/13 04:32:51 INFO : three: Copied (new) 2025/03/13 04:32:51 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (14.45s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:32:53 DEBUG : dst/one: md5 = de266e3c99e99e3dbf82b10bf3e07c71 OK 2025/03/13 04:32:53 DEBUG : dst/two: md5 = 9888959c01712c2f6a962c40868b2da5 OK 2025/03/13 04:32:55 DEBUG : dst/three.txt: md5 = f2b062be95cb803263f6f80ec80662ca OK 2025/03/13 04:32:56 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/dst" 2025/03/13 04:32:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst.bin" 2025/03/13 04:32:56 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst.bin: Auto set use_segments_container to true 2025/03/13 04:32:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst" 2025/03/13 04:32:57 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst: Auto set use_segments_container to true 2025/03/13 04:32:57 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/backup" 2025/03/13 04:32:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/backup.bin" 2025/03/13 04:32:58 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/backup.bin: Auto set use_segments_container to true 2025/03/13 04:32:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/backup" 2025/03/13 04:32:58 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/backup: Auto set use_segments_container to true 2025/03/13 04:32:59 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/13 04:32:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:32:59 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:32:59 DEBUG : two: Unchanged skipping 2025/03/13 04:33:00 INFO : one: Copied (server-side copy) 2025/03/13 04:33:00 INFO : one: Deleted 2025/03/13 04:33:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:33:00 DEBUG : one: md5 = 4ffcf02b18302613e6e38f3c3bb8c1cb OK 2025/03/13 04:33:00 INFO : one: Copied (new) 2025/03/13 04:33:00 DEBUG : Waiting for deletions to finish 2025/03/13 04:33:01 INFO : three.txt: Copied (server-side copy) 2025/03/13 04:33:01 INFO : three.txt: Deleted 2025/03/13 04:33:01 INFO : three.txt: Moved into backup dir 2025/03/13 04:33:01 DEBUG : dst/three.txt: md5 = be329f1f999f4ec3cf840ba2b117e2bc OK 2025/03/13 04:33:02 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/13 04:33:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:33:02 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:02 DEBUG : two: Unchanged skipping 2025/03/13 04:33:02 INFO : one: Copied (server-side copy) 2025/03/13 04:33:02 INFO : one: Deleted 2025/03/13 04:33:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:33:03 DEBUG : one: md5 = d1fc1730a90e4e85f54454a6319f4cc8 OK 2025/03/13 04:33:03 INFO : one: Copied (new) 2025/03/13 04:33:03 DEBUG : Waiting for deletions to finish 2025/03/13 04:33:03 INFO : three.txt: Copied (server-side copy) 2025/03/13 04:33:03 INFO : three.txt: Deleted 2025/03/13 04:33:03 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (12.62s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:05 DEBUG : dst/one: md5 = df315da8e828f96220ac55e88784d104 OK 2025/03/13 04:33:06 DEBUG : dst/two: md5 = b13030be3f888730db722a51a12a99b4 OK 2025/03/13 04:33:06 DEBUG : dst/three.txt: md5 = 2ddf28e711eb25ff9f217428b7f889ba OK 2025/03/13 04:33:06 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst.bin" 2025/03/13 04:33:07 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst.bin: Auto set use_segments_container to true 2025/03/13 04:33:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:08 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst: Auto set use_segments_container to true 2025/03/13 04:33:08 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/backup" 2025/03/13 04:33:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/backup.bin" 2025/03/13 04:33:08 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/backup.bin: Auto set use_segments_container to true 2025/03/13 04:33:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/backup" 2025/03/13 04:33:09 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/backup: Auto set use_segments_container to true 2025/03/13 04:33:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:33:09 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/13 04:33:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:10 DEBUG : two: Unchanged skipping 2025/03/13 04:33:10 INFO : one: Copied (server-side copy) to: one.bak 2025/03/13 04:33:11 INFO : one: Deleted 2025/03/13 04:33:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:33:11 DEBUG : one: md5 = 978dcefd89e83052361ba29bce13f782 OK 2025/03/13 04:33:11 INFO : one: Copied (new) 2025/03/13 04:33:11 DEBUG : Waiting for deletions to finish 2025/03/13 04:33:11 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/13 04:33:11 INFO : three.txt: Deleted 2025/03/13 04:33:11 INFO : three.txt: Moved into backup dir 2025/03/13 04:33:12 DEBUG : dst/three.txt: md5 = 9b0163aa3dd90f775599e9091428e3b6 OK 2025/03/13 04:33:13 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/13 04:33:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:33:13 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:13 DEBUG : two: Unchanged skipping 2025/03/13 04:33:13 INFO : one: Copied (server-side copy) to: one.bak 2025/03/13 04:33:13 INFO : one: Deleted 2025/03/13 04:33:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:33:13 DEBUG : one: md5 = d98489521fd52866542dd4bafaf4c31d OK 2025/03/13 04:33:13 INFO : one: Copied (new) 2025/03/13 04:33:13 DEBUG : Waiting for deletions to finish 2025/03/13 04:33:14 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/13 04:33:14 INFO : three.txt: Deleted 2025/03/13 04:33:14 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (10.19s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:16 DEBUG : dst/one: md5 = d5ecdf2bd6264f1e54b9c9ff12196808 OK 2025/03/13 04:33:16 DEBUG : dst/two: md5 = a910e2482fa0303f96f21548ee91b1d9 OK 2025/03/13 04:33:16 DEBUG : dst/three.txt: md5 = 227c88dc7ab7c265db00349522af07df OK 2025/03/13 04:33:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst.bin" 2025/03/13 04:33:17 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst.bin: Auto set use_segments_container to true 2025/03/13 04:33:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:18 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst: Auto set use_segments_container to true 2025/03/13 04:33:18 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/backup" 2025/03/13 04:33:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/backup.bin" 2025/03/13 04:33:19 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/backup.bin: Auto set use_segments_container to true 2025/03/13 04:33:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/backup" 2025/03/13 04:33:19 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/backup: Auto set use_segments_container to true 2025/03/13 04:33:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/13 04:33:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:33:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:20 DEBUG : two: Unchanged skipping 2025/03/13 04:33:20 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/03/13 04:33:20 INFO : one: Deleted 2025/03/13 04:33:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:33:21 DEBUG : one: md5 = 3e3c1979ab82589e5de431839b7cd9b9 OK 2025/03/13 04:33:21 INFO : one: Copied (new) 2025/03/13 04:33:21 DEBUG : Waiting for deletions to finish 2025/03/13 04:33:22 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/03/13 04:33:22 INFO : three.txt: Deleted 2025/03/13 04:33:22 INFO : three.txt: Moved into backup dir 2025/03/13 04:33:23 DEBUG : dst/three.txt: md5 = 7e541cc89d18e93f347b7d3da83c41c3 OK 2025/03/13 04:33:23 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/13 04:33:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:33:23 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:23 DEBUG : two: Unchanged skipping 2025/03/13 04:33:23 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/03/13 04:33:24 INFO : one: Deleted 2025/03/13 04:33:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:33:24 DEBUG : one: md5 = ba2c009cd6715ee3fbad90d78649edcc OK 2025/03/13 04:33:24 INFO : one: Copied (new) 2025/03/13 04:33:24 DEBUG : Waiting for deletions to finish 2025/03/13 04:33:24 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/03/13 04:33:24 INFO : three.txt: Deleted 2025/03/13 04:33:24 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (10.12s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:26 DEBUG : dst/one: md5 = 4e5a756e6bad731f643e76b419d18581 OK 2025/03/13 04:33:26 DEBUG : dst/two: md5 = bffec4cf00c1dd7d86c2fd2ba1b66d7b OK 2025/03/13 04:33:26 DEBUG : dst/three.txt: md5 = 676ee289b21bd5d030dc0a15918780e4 OK 2025/03/13 04:33:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst.bin" 2025/03/13 04:33:27 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst.bin: Auto set use_segments_container to true 2025/03/13 04:33:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:28 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst: Auto set use_segments_container to true 2025/03/13 04:33:28 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/13 04:33:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:33:28 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:28 DEBUG : two: Unchanged skipping 2025/03/13 04:33:29 INFO : one: Copied (server-side copy) to: one.bak 2025/03/13 04:33:29 INFO : one: Deleted 2025/03/13 04:33:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:33:29 DEBUG : one: md5 = 014319f97e5dec94f948c7b3377d5d7b OK 2025/03/13 04:33:29 INFO : one: Copied (new) 2025/03/13 04:33:29 DEBUG : Waiting for deletions to finish 2025/03/13 04:33:29 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/13 04:33:30 INFO : three.txt: Deleted 2025/03/13 04:33:30 INFO : three.txt: Moved into backup dir 2025/03/13 04:33:30 DEBUG : dst/three.txt: md5 = e2b59344ecb2f4542c40373751a422f0 OK 2025/03/13 04:33:31 DEBUG : one.bak: Excluded (Path Filter) 2025/03/13 04:33:31 DEBUG : one.bak: Excluded 2025/03/13 04:33:31 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/03/13 04:33:31 DEBUG : three.txt.bak: Excluded 2025/03/13 04:33:31 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/13 04:33:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for checks to finish 2025/03/13 04:33:31 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:31 DEBUG : two: Unchanged skipping 2025/03/13 04:33:31 INFO : one: Copied (server-side copy) to: one.bak 2025/03/13 04:33:31 INFO : one: Deleted 2025/03/13 04:33:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe/dst': Waiting for transfers to finish 2025/03/13 04:33:32 DEBUG : one: md5 = b90eddbe62132ef719224c4c6d0329d7 OK 2025/03/13 04:33:32 INFO : one: Copied (new) 2025/03/13 04:33:32 DEBUG : Waiting for deletions to finish 2025/03/13 04:33:33 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/13 04:33:33 INFO : three.txt: Deleted 2025/03/13 04:33:33 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (8.78s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:34 DEBUG : dst/one: md5 = 7a5e95ef42ecd1081469c4892fc2ba8a OK 2025/03/13 04:33:35 DEBUG : dst/two: md5 = d9d444b215f983fe944eb2445c9b1b4f OK 2025/03/13 04:33:35 DEBUG : dst/three.txt: md5 = 9e96ecaefe1891e07767db392ce045b0 OK 2025/03/13 04:33:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst.bin" 2025/03/13 04:33:36 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst.bin: Auto set use_segments_container to true 2025/03/13 04:33:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:37 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst: Auto set use_segments_container to true 2025/03/13 04:33:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/13 04:33:37 INFO : one: Copied (server-side copy) to: one.bak 2025/03/13 04:33:37 INFO : one: Deleted 2025/03/13 04:33:37 DEBUG : one: md5 = 8de894209682cd0929454ab17fb7fc01 OK 2025/03/13 04:33:37 INFO : one: Copied (new) 2025/03/13 04:33:37 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:37 DEBUG : two: Unchanged skipping 2025/03/13 04:33:37 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/03/13 04:33:38 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/13 04:33:39 INFO : three.txt: Deleted 2025/03/13 04:33:39 DEBUG : three.txt: md5 = aa4fce32abfa46a8e6f46741a0727a54 OK 2025/03/13 04:33:39 INFO : three.txt: Copied (new) 2025/03/13 04:33:40 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/13 04:33:40 INFO : one: Copied (server-side copy) to: one.bak 2025/03/13 04:33:40 INFO : one: Deleted 2025/03/13 04:33:40 DEBUG : one: md5 = eadbad65c9678ec5e920f36b1576f8bc OK 2025/03/13 04:33:40 INFO : one: Copied (new) 2025/03/13 04:33:40 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:40 DEBUG : two: Unchanged skipping 2025/03/13 04:33:40 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/03/13 04:33:41 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/03/13 04:33:41 INFO : three.txt: Deleted 2025/03/13 04:33:41 DEBUG : three.txt: md5 = 22c70968080c8277ea1992ded8b0c8e7 OK 2025/03/13 04:33:41 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (7.92s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:42 DEBUG : dst/one: md5 = f43e95b37367962febf6f21e33ed0fc0 OK 2025/03/13 04:33:43 DEBUG : dst/two: md5 = 522554c60e5caa34c6b3dc70c5dd0249 OK 2025/03/13 04:33:43 DEBUG : dst/three.txt: md5 = 24ecbc226d11af492a9779ce068406b4 OK 2025/03/13 04:33:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst.bin" 2025/03/13 04:33:44 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst.bin: Auto set use_segments_container to true 2025/03/13 04:33:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wihurer3lipe/dst" 2025/03/13 04:33:44 DEBUG : Swift container crypt path rclone-test-wihurer3lipe/dst: Auto set use_segments_container to true 2025/03/13 04:33:45 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/13 04:33:45 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/03/13 04:33:45 INFO : one: Deleted 2025/03/13 04:33:45 DEBUG : one: md5 = 71e11ba1fcca520b15c00d81f2f97895 OK 2025/03/13 04:33:45 INFO : one: Copied (new) 2025/03/13 04:33:45 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:45 DEBUG : two: Unchanged skipping 2025/03/13 04:33:45 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/03/13 04:33:46 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/03/13 04:33:46 INFO : three.txt: Deleted 2025/03/13 04:33:47 DEBUG : three.txt: md5 = 4a9c08719ca739396287d9f6bae2e316 OK 2025/03/13 04:33:47 INFO : three.txt: Copied (new) 2025/03/13 04:33:47 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/13 04:33:48 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/03/13 04:33:48 INFO : one: Deleted 2025/03/13 04:33:48 DEBUG : one: md5 = ac4b540fce7be6350de2b13bc5b6fbe2 OK 2025/03/13 04:33:48 INFO : one: Copied (new) 2025/03/13 04:33:48 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:48 DEBUG : two: Unchanged skipping 2025/03/13 04:33:48 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/03/13 04:33:48 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/03/13 04:33:49 INFO : three.txt: Deleted 2025/03/13 04:33:49 DEBUG : three.txt: md5 = 838f9c3894b55ceaffc9787fa29fb365 OK 2025/03/13 04:33:49 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (7.98s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:51 DEBUG : Testêé: md5 = c04c10754c66ba780a63470477607bc2 OK 2025/03/13 04:33:51 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/03/13 04:33:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:33:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:33:52 DEBUG : Testêé: md5 = bddfb58fc2b42ffb2f2b623a2f2cc6c4 OK 2025/03/13 04:33:52 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/03/13 04:33:52 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (2.16s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:53 DEBUG : existing: Need to transfer - File not found at Destination 2025/03/13 04:33:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:33:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:33:53 DEBUG : existing: md5 = 2eb1bb626e222e8afe9332773069a157 OK 2025/03/13 04:33:53 INFO : existing: Copied (new) 2025/03/13 04:33:53 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:33:53 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/03/13 04:33:53 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/03/13 04:33:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:33:53 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': not deleting files as there were IO errors 2025/03/13 04:33:53 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncImmutable (1.70s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:55 DEBUG : EXISTING: md5 = a2427225b8cf980ee1601304f54bcd57 OK 2025/03/13 04:33:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:33:56 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:33:56 DEBUG : existing: Unchanged skipping 2025/03/13 04:33:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:33:56 DEBUG : Waiting for deletions to finish 2025/03/13 04:33:56 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (2.11s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.10s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", 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-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", 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-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.39s) --- SKIP: TestMaxTransfer/Hard (0.15s) --- SKIP: TestMaxTransfer/Soft (0.15s) --- SKIP: TestMaxTransfer/Cautious (0.10s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:33:57 DEBUG : both0: md5 = 0a86ccf6774cc12c31d9f439372c9a8c OK 2025/03/13 04:33:58 DEBUG : only0: md5 = 1e221b596a89ce5b57fc4cef445a001c OK 2025/03/13 04:33:59 DEBUG : both1: md5 = 0606129f5b0a76c7a2037a3f397d089f OK 2025/03/13 04:34:00 DEBUG : only1: md5 = 6b3b85a2f6a57858423342298bdbe5cc OK 2025/03/13 04:34:00 DEBUG : both2: md5 = ee00f407609f21b5a2378a716c6ea0c9 OK 2025/03/13 04:34:00 DEBUG : only2: md5 = 8c7ba4d3c60679a73e0efd25ed2e2177 OK 2025/03/13 04:34:01 DEBUG : both3: md5 = 99844d2b6bc9ae48648c8bfd43f896ab OK 2025/03/13 04:34:01 DEBUG : only3: md5 = 5517f5a0146bd6bd48e4db30bcda059f OK 2025/03/13 04:34:02 DEBUG : both4: md5 = 1b87d81f63c429ceb893e6db0aa064ea OK 2025/03/13 04:34:02 DEBUG : only4: md5 = 668de963432c8f5adada2383db99cf18 OK 2025/03/13 04:34:02 DEBUG : both5: md5 = 92a6a4d1379a2e859d3baad7451782ff OK 2025/03/13 04:34:03 DEBUG : only5: md5 = 171049be51b5ac705d46732fd67ba71d OK 2025/03/13 04:34:03 DEBUG : both6: md5 = 70bedd006cd17aff4c18225af35dfdb2 OK 2025/03/13 04:34:05 DEBUG : only6: md5 = a35e69b399eb3d46604680999a3319c7 OK 2025/03/13 04:34:05 DEBUG : both7: md5 = e2f08c28c978e89bc2eb923fb0dcc498 OK 2025/03/13 04:34:06 DEBUG : only7: md5 = 4e5e7bbed4b543e85127ab4df7d86e18 OK 2025/03/13 04:34:07 DEBUG : both8: md5 = f61871a944a892d9bface15ce7d60ebc OK 2025/03/13 04:34:07 DEBUG : only8: md5 = 413b7992b61e8e62a3b6ceb60f8d39d5 OK 2025/03/13 04:34:08 DEBUG : both9: md5 = 7b9041b425a2b41a07b965e81de4a4b5 OK 2025/03/13 04:34:08 DEBUG : only9: md5 = 182c35cd5c0e2b3efea873f0b099c579 OK 2025/03/13 04:34:09 DEBUG : both10: md5 = bd97f21b6e1d706e71ef4e9cbbb1c5c2 OK 2025/03/13 04:34:09 DEBUG : only10: md5 = ace4cbf10a4fa6d4fb4ed594148ac4c5 OK 2025/03/13 04:34:12 DEBUG : both11: md5 = 89656cb8b65cdb56cf9e70a9dcc6f40a OK 2025/03/13 04:34:12 DEBUG : only11: md5 = d5f0d5e6ddc57bf2eee5ad8611a4e7f5 OK 2025/03/13 04:34:12 DEBUG : both12: md5 = 8cb3ec6def7f3804ab297b6202c5856a OK 2025/03/13 04:34:16 DEBUG : only12: md5 = 9a61263e1e4111a4cf355ea006b7c59c OK 2025/03/13 04:34:16 DEBUG : both13: md5 = f962cc9a2a8c689143208d533ca201c5 OK 2025/03/13 04:34:16 DEBUG : only13: md5 = 288d299603bf68f8928540e4d6e312b4 OK 2025/03/13 04:34:17 DEBUG : both14: md5 = b2eafd0bb9ac9aa15bc5a6d4ada32a99 OK 2025/03/13 04:34:18 DEBUG : only14: md5 = ad1a43d697493d3124b51dfb246e576a OK 2025/03/13 04:34:18 DEBUG : both15: md5 = d8f7367ffb6453d2cf169926e0d331cc OK 2025/03/13 04:34:19 DEBUG : only15: md5 = d4ad7c0165d25cf62a21cc0126cb1401 OK 2025/03/13 04:34:19 DEBUG : both16: md5 = f5380b55026ce065af4ec90811fa1f69 OK 2025/03/13 04:34:19 DEBUG : only16: md5 = 334f8629cbe6bd89f43642ac4c73d9fc OK 2025/03/13 04:34:21 DEBUG : both17: md5 = 14b6db9fcecb992b551a907f3df1389a OK 2025/03/13 04:34:22 DEBUG : only17: md5 = fa1b55e1ad320f08a94d2962b97a6c55 OK 2025/03/13 04:34:22 DEBUG : both18: md5 = a89c222ff38d8073288a666aaeefdba6 OK 2025/03/13 04:34:23 DEBUG : only18: md5 = 17e6f08c7a9f53b0e9b9622f0ff3170e OK 2025/03/13 04:34:23 DEBUG : both19: md5 = a3dec18b435a24e59d43731e819f1857 OK 2025/03/13 04:34:23 DEBUG : only19: md5 = 14a8209818949c71b7b37dae2bab75e8 OK 2025/03/13 04:34:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:34:26 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both0: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both1: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both10: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both11: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both12: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both13: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both14: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both15: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both16: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both17: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both19: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both2: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both3: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both4: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both5: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both6: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both7: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both8: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:26 DEBUG : both18: Unchanged skipping 2025/03/13 04:34:26 DEBUG : both9: Unchanged skipping 2025/03/13 04:34:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:34:26 DEBUG : Waiting for deletions to finish 2025/03/13 04:34:26 INFO : only4: Deleted 2025/03/13 04:34:26 INFO : only10: Deleted 2025/03/13 04:34:26 INFO : only19: Deleted 2025/03/13 04:34:27 INFO : only18: Deleted 2025/03/13 04:34:27 INFO : only5: Deleted 2025/03/13 04:34:27 INFO : only0: Deleted 2025/03/13 04:34:27 INFO : only1: Deleted 2025/03/13 04:34:27 INFO : only13: Deleted 2025/03/13 04:34:27 INFO : only14: Deleted 2025/03/13 04:34:27 INFO : only15: Deleted 2025/03/13 04:34:27 INFO : only2: Deleted 2025/03/13 04:34:27 INFO : only6: Deleted 2025/03/13 04:34:27 INFO : only11: Deleted 2025/03/13 04:34:28 INFO : only16: Deleted 2025/03/13 04:34:28 INFO : only12: Deleted 2025/03/13 04:34:28 INFO : only9: Deleted 2025/03/13 04:34:28 INFO : only17: Deleted 2025/03/13 04:34:28 INFO : only3: Deleted 2025/03/13 04:34:28 INFO : only8: Deleted 2025/03/13 04:34:28 INFO : only7: Deleted 2025/03/13 04:34:28 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (40.09s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:34:37 DEBUG : both0: md5 = 08a5bf7c25f378b22f170fc354a97bc7 OK 2025/03/13 04:34:37 DEBUG : only0: md5 = 3463d78f7fb4270a1287a2c8ba69e178 OK 2025/03/13 04:34:38 DEBUG : both1: md5 = 19c7dbaca8ff7501978c99d42552dc64 OK 2025/03/13 04:34:38 DEBUG : only1: md5 = bf13158e8967366c202e787dc47025a3 OK 2025/03/13 04:34:38 DEBUG : both2: md5 = 0d9be91d6998826be4e3ba411ed98f07 OK 2025/03/13 04:34:38 DEBUG : only2: md5 = 3fa811b625457882043e9c70765f5f0d OK 2025/03/13 04:34:39 DEBUG : both3: md5 = 4cb10e9dbe132cc03ee7c0ce471c851d OK 2025/03/13 04:34:39 DEBUG : only3: md5 = 98cdc4b559c55e8aa0c602aca9e5128e OK 2025/03/13 04:34:39 DEBUG : both4: md5 = 9882d8bc4bfedd55cb5ec36ea1c87f3f OK 2025/03/13 04:34:39 DEBUG : only4: md5 = fc5aa46cdc935cff28a07a2232c3ca1c OK 2025/03/13 04:34:39 DEBUG : both5: md5 = 19878879c4a88c56e6a0465f7569ceca OK 2025/03/13 04:34:39 DEBUG : only5: md5 = 4cff12303faa7e8451b5a782259a5641 OK 2025/03/13 04:34:40 DEBUG : both6: md5 = 78e38cb1d7aa4bd345497c1d79a6bf46 OK 2025/03/13 04:34:40 DEBUG : only6: md5 = 2bd3a8e9c21a080fecb227393db08713 OK 2025/03/13 04:34:40 DEBUG : both7: md5 = 7288ee3f9e36ec9cc40bee4e372364b6 OK 2025/03/13 04:34:41 DEBUG : only7: md5 = b1d4e1909ba0da479c8c89c08ea09388 OK 2025/03/13 04:34:42 DEBUG : both8: md5 = f0fc411d647256ee919e91cab3c713b3 OK 2025/03/13 04:34:42 DEBUG : only8: md5 = bb61c208b6591a50991c9cdc22196fe0 OK 2025/03/13 04:34:42 DEBUG : both9: md5 = fd04a7072eca30e40bb9d69ce419fcf7 OK 2025/03/13 04:34:42 DEBUG : only9: md5 = 456aafdf8cdb6c41a632735a42aa7771 OK 2025/03/13 04:34:42 DEBUG : both10: md5 = 81ec68d8e44c565be459c09907e6e521 OK 2025/03/13 04:34:42 DEBUG : only10: md5 = d6c0771614ba1baecda71c2d752b9c19 OK 2025/03/13 04:34:43 DEBUG : both11: md5 = bb0717e4e446b36363841b3efc4a947b OK 2025/03/13 04:34:43 DEBUG : only11: md5 = 0c8fb375ec60897ba4244e2c63e3f840 OK 2025/03/13 04:34:43 DEBUG : both12: md5 = 584b8e1af40a24321584e00c27470085 OK 2025/03/13 04:34:43 DEBUG : only12: md5 = a6b615080a52a0d1cca1c255519069e7 OK 2025/03/13 04:34:43 DEBUG : both13: md5 = 24437187e877437250ab3d4d585c1fe2 OK 2025/03/13 04:34:44 DEBUG : only13: md5 = f2908ac2d32a3daaa278e790c367f686 OK 2025/03/13 04:34:44 DEBUG : both14: md5 = f58d5ebbc5946edb8da589d495961710 OK 2025/03/13 04:34:44 DEBUG : only14: md5 = 36cd61d599771ff173816a123989e591 OK 2025/03/13 04:34:44 DEBUG : both15: md5 = 9ce43a6082a20c0fe5002fb802b1990e OK 2025/03/13 04:34:44 DEBUG : only15: md5 = 7a3ecaca0da4bf4c1d65977fbf5edae6 OK 2025/03/13 04:34:44 DEBUG : both16: md5 = d472d5eff1a5822e58637ab59001f093 OK 2025/03/13 04:34:45 DEBUG : only16: md5 = daed332bf232c6734602ad85bf968f53 OK 2025/03/13 04:34:45 DEBUG : both17: md5 = 81f09b3cc88599adacb6d4e7c10931ed OK 2025/03/13 04:34:45 DEBUG : only17: md5 = 9d72baed855a60c5de9a65445bf9e711 OK 2025/03/13 04:34:45 DEBUG : both18: md5 = 041297220714b9f74b25477e3cac4cb4 OK 2025/03/13 04:34:46 DEBUG : only18: md5 = d4c4bd93f6fbc020a35a48f1e3514481 OK 2025/03/13 04:34:46 DEBUG : both19: md5 = 3c334a355c8eae855d48476c107f4102 OK 2025/03/13 04:34:46 DEBUG : only19: md5 = e8e7702f3d85742025df0c335f92242d OK 2025/03/13 04:34:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for checks to finish 2025/03/13 04:34:48 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:48 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:48 DEBUG : both11: Unchanged skipping 2025/03/13 04:34:48 DEBUG : both0: Unchanged skipping 2025/03/13 04:34:48 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:48 DEBUG : both1: Unchanged skipping 2025/03/13 04:34:48 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:48 DEBUG : both10: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both12: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both13: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both14: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both15: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both16: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both17: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both18: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both19: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both2: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both3: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both4: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both5: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both6: Unchanged skipping 2025/03/13 04:34:49 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/03/13 04:34:49 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both7: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both8: Unchanged skipping 2025/03/13 04:34:49 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/13 04:34:49 DEBUG : both9: Unchanged skipping 2025/03/13 04:34:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Waiting for transfers to finish 2025/03/13 04:34:49 DEBUG : only10: md5 = acbf5e2af45fe363663e6811c3ec5d66 OK 2025/03/13 04:34:49 INFO : only10: Copied (replaced existing) 2025/03/13 04:34:49 DEBUG : only11: md5 = cb2f4c93998c52a8b824b6fe2f956490 OK 2025/03/13 04:34:49 INFO : only11: Copied (replaced existing) 2025/03/13 04:34:49 DEBUG : only1: md5 = c4babffcb544f1520ff00699ec7f7c27 OK 2025/03/13 04:34:49 INFO : only1: Copied (replaced existing) 2025/03/13 04:34:49 DEBUG : only0: md5 = 5024923dce2c7ad1b1d6ae3a4b38365a OK 2025/03/13 04:34:49 INFO : only0: Copied (replaced existing) 2025/03/13 04:34:49 DEBUG : only13: md5 = aa8e6d9df98884b3fa68fc89dcca8318 OK 2025/03/13 04:34:49 INFO : only13: Copied (replaced existing) 2025/03/13 04:34:49 DEBUG : only15: md5 = 0d0a7d4af838cc61a79726dd9adf9b41 OK 2025/03/13 04:34:49 INFO : only15: Copied (replaced existing) 2025/03/13 04:34:49 DEBUG : only16: md5 = 5e3efb7997352a42baa08aa850115c89 OK 2025/03/13 04:34:49 INFO : only16: Copied (replaced existing) 2025/03/13 04:34:49 DEBUG : only17: md5 = ab5648d22b654a97df37a5fec3a33bf7 OK 2025/03/13 04:34:49 INFO : only17: Copied (replaced existing) 2025/03/13 04:34:49 DEBUG : only12: md5 = 7834b94d6aad11556e728b0a6a51e925 OK 2025/03/13 04:34:49 INFO : only12: Copied (replaced existing) 2025/03/13 04:34:49 DEBUG : only14: md5 = 32cc16529ae62563d4be0fbff686dfaf OK 2025/03/13 04:34:49 INFO : only14: Copied (replaced existing) 2025/03/13 04:34:50 DEBUG : only18: md5 = ad00c6b0e187074e76487be965f762d1 OK 2025/03/13 04:34:50 INFO : only18: Copied (replaced existing) 2025/03/13 04:34:50 DEBUG : only19: md5 = 9047092a936a1ced7efd1a32a9fd7cf2 OK 2025/03/13 04:34:50 INFO : only19: Copied (replaced existing) 2025/03/13 04:34:50 DEBUG : only2: md5 = 4fade7fd1ac4e7e2570bbb3192e50497 OK 2025/03/13 04:34:50 INFO : only2: Copied (replaced existing) 2025/03/13 04:34:50 DEBUG : only3: md5 = 1d29e8344e6957769177eb383714c944 OK 2025/03/13 04:34:50 INFO : only3: Copied (replaced existing) 2025/03/13 04:34:50 DEBUG : only4: md5 = b42d3f968b0a39f90fd8d4a1ba244620 OK 2025/03/13 04:34:50 INFO : only4: Copied (replaced existing) 2025/03/13 04:34:50 DEBUG : only5: md5 = 0b67f4970bc257068fef3cc543b110a1 OK 2025/03/13 04:34:50 INFO : only5: Copied (replaced existing) 2025/03/13 04:34:50 DEBUG : only6: md5 = 0095dd0dae6f0e1873482221bc823fcd OK 2025/03/13 04:34:50 INFO : only6: Copied (replaced existing) 2025/03/13 04:34:50 DEBUG : only9: md5 = d1c3dd5410efed046c6026075cb2a008 OK 2025/03/13 04:34:50 INFO : only9: Copied (replaced existing) 2025/03/13 04:34:50 DEBUG : only8: md5 = 530fdec612e32f1392dd0c0701c347b3 OK 2025/03/13 04:34:50 INFO : only8: Copied (replaced existing) 2025/03/13 04:34:51 DEBUG : only7: md5 = 61f016e69cd96998f61949325fcb6f15 OK 2025/03/13 04:34:51 INFO : only7: Copied (replaced existing) 2025/03/13 04:34:51 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (25.34s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:35:02 DEBUG : empty_dir: Making directory with metadata 2025/03/13 04:35:02 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/13 04:35:02 DEBUG : empty_on_remote: Making directory with metadata 2025/03/13 04:35:02 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/13 04:35:02 INFO : empty_on_remote: Making directory 2025/03/13 04:35:02 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:35:05 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/03/13 04:35:05 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/03/13 04:35:05 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/03/13 04:35:05 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTime (4.87s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:35:07 DEBUG : empty_dir: Making directory with metadata 2025/03/13 04:35:07 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/13 04:35:07 DEBUG : empty_on_remote: Making directory with metadata 2025/03/13 04:35:07 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/13 04:35:07 INFO : empty_on_remote: Making directory 2025/03/13 04:35:07 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:35:08 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/03/13 04:35:08 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/03/13 04:35:08 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/03/13 04:35:08 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/03/13 04:35:08 INFO : empty_dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (4.22s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:35:11 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/13 04:35:11 INFO : sub dir: Making directory 2025/03/13 04:35:11 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-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (2.47s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" 2025/03/13 04:35:14 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/03/13 04:35:14 INFO : sub dir: Making directory 2025/03/13 04:35:14 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-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe'", Local "Local file system at /tmp/rclone329930444", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (2.29s) PASS 2025/03/13 04:35:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wihurer3lipe': Purge remote 2025/03/13 04:35:16 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 5m26.676414963s (try 1/5)