"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2024/10/30 04:38:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze" 2024/10/30 04:38:16 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 04:38:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze.bin" 2024/10/30 04:38:16 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze.bin: Auto set use_segments_container to true 2024/10/30 04:38:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze" 2024/10/30 04:38:17 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze: Auto set use_segments_container to true 2024/10/30 04:38:17 DEBUG : Creating backend with remote "/tmp/rclone401703151" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.03s) === 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-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:18 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyWithDryRun (0.60s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:18 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/10/30 04:38:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:18 DEBUG : sub dir/hello world: md5 = e163ae76d9c05ac6e9a319d944cc817b OK 2024/10/30 04:38:18 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (1.68s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.67s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" sync_test.go:97: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.09s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:20 DEBUG : Creating backend with remote "/non-existing" 2024/10/30 04:38:21 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2024/10/30 04:38:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyMissingDirectory (0.24s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:21 DEBUG : sub dir/hello world: md5 = 58ba23dddcba63233636e895f808e20f OK 2024/10/30 04:38:21 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyNoTraverse (1.23s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:22 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Running all checks before starting transfers 2024/10/30 04:38:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:22 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Checks finished, now starting transfers 2024/10/30 04:38:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:22 DEBUG : sub dir/hello world: md5 = bedaa9f3dc1b26666a1f87258167e403 OK 2024/10/30 04:38:22 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyCheckFirst (1.78s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:24 ERROR : Ignoring --no-traverse with sync 2024/10/30 04:38:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:24 DEBUG : sub dir/hello world: md5 = cfb88efa11c25ca9fa8812bcee1de0ee OK 2024/10/30 04:38:24 INFO : sub dir/hello world: Copied (new) 2024/10/30 04:38:24 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncNoTraverse (1.21s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:25 DEBUG : hello world2: Need to transfer - File not found at Destination 2024/10/30 04:38:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:26 DEBUG : hello world2: md5 = 5b242ece5c26528b7e9dcdaaf8a0ca66 OK 2024/10/30 04:38:26 INFO : hello world2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyWithDepth (2.31s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:27 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:38:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:28 DEBUG : potato2: md5 = 6307430a1b6a63150edba9ab864f288e OK 2024/10/30 04:38:28 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyWithFilesFrom (1.65s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:29 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:38:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:29 DEBUG : potato2: md5 = c0efda88f1515938dff8f094c838a825 OK 2024/10/30 04:38:29 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyWithFilesFromAndNoTraverse (1.46s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:30 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/10/30 04:38:30 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/10/30 04:38:30 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2024/10/30 04:38:30 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/10/30 04:38:30 DEBUG : sub dir: Making directory 2024/10/30 04:38:30 DEBUG : sub dir2: Making directory 2024/10/30 04:38:30 DEBUG : sub dir2/sub sub dir2: Making directory 2024/10/30 04:38:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:31 DEBUG : sub dir/hello world: md5 = 805f8d12e521726d6e7e907e40007469 OK 2024/10/30 04:38:31 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2" 2024/10/30 04:38:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (1.48s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:32 DEBUG : sub dir2: Making directory 2024/10/30 04:38:32 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2024/10/30 04:38:32 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/10/30 04:38:32 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:32 DEBUG : sub dir/hello world: md5 = 1a2050216de47e4d46ac448c9649c99a OK 2024/10/30 04:38:32 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (0.79s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:33 DEBUG : sub dir2: Making directory with metadata 2024/10/30 04:38:33 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/10/30 04:38:33 DEBUG : sub dir: Making directory 2024/10/30 04:38:33 DEBUG : sub dir2: Making directory 2024/10/30 04:38:33 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:33 DEBUG : sub dir/hello world: md5 = bd823916d5f765f36abf44e1253e2351 OK 2024/10/30 04:38:33 INFO : sub dir/hello world: Copied (new) 2024/10/30 04:38:33 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2024/10/30 04:38:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2024/10/30 04:38:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (1.39s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" sync_test.go:408: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.10s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:34 DEBUG : sub dir2: Making directory 2024/10/30 04:38:34 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:34 DEBUG : sub dir/hello world: md5 = 0d274e80b13a0c634ee51af55b930ea9 OK 2024/10/30 04:38:34 INFO : sub dir/hello world: Copied (new) 2024/10/30 04:38:34 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (0.93s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:35 DEBUG : sub dir2: Making directory with metadata 2024/10/30 04:38:35 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2024/10/30 04:38:35 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/10/30 04:38:35 DEBUG : sub dir: Making directory 2024/10/30 04:38:35 DEBUG : sub dir2: Making directory 2024/10/30 04:38:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:35 DEBUG : sub dir/hello world: md5 = ab1a293d37938ff36a4256248ada5ed8 OK 2024/10/30 04:38:35 INFO : sub dir/hello world: Copied (new) 2024/10/30 04:38:35 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" fstest.go:244: Filtering empty directory "sub dir2" 2024/10/30 04:38:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (1.40s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", 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-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:37 DEBUG : sub dir2: Making directory 2024/10/30 04:38:37 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:37 DEBUG : sub dir/hello world: md5 = 55cd0a23a2cc0a50a0d8531e151cbabf OK 2024/10/30 04:38:37 INFO : sub dir/hello world: Copied (new) 2024/10/30 04:38:37 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (0.87s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:38 DEBUG : sub dir/hello world: md5 = 9df74724da92baf9d0b26ef4d3eace49 OK 2024/10/30 04:38:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-gawumuz1zequ" 2024/10/30 04:38:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gawumuz1zequ.bin" 2024/10/30 04:38:38 DEBUG : Swift container crypt path rclone-test-gawumuz1zequ.bin: Auto set use_segments_container to true 2024/10/30 04:38:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-gawumuz1zequ" 2024/10/30 04:38:39 DEBUG : Swift container crypt path rclone-test-gawumuz1zequ: Auto set use_segments_container to true sync_test.go:590: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze' -> Encrypted drive 'TestCryptSwift:rclone-test-gawumuz1zequ' 2024/10/30 04:38:40 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gawumuz1zequ': Waiting for checks to finish 2024/10/30 04:38:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gawumuz1zequ': Waiting for transfers to finish 2024/10/30 04:38:41 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-gawumuz1zequ': Purge remote 2024/10/30 04:38:41 DEBUG : Waiting for deletions to finish 2024/10/30 04:38:41 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (4.72s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:42 DEBUG : sub dir/hello world: md5 = 372bbabd67b486e33298e8d355944238 OK 2024/10/30 04:38:43 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/10/30 04:38:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:43 DEBUG : sub dir/hello world: md5 = aa64e072bb901c0bc3fe5f0d7f166440 OK 2024/10/30 04:38:43 INFO : sub dir/hello world: Copied (replaced existing) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyOverSelf (1.52s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:44 DEBUG : sub dir/hello world: md5 = ee460102cab5b0ab548b5dca6568bf90 OK 2024/10/30 04:38:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-nuxigev8fiva" 2024/10/30 04:38:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nuxigev8fiva.bin" 2024/10/30 04:38:44 DEBUG : Swift container crypt path rclone-test-nuxigev8fiva.bin: Auto set use_segments_container to true 2024/10/30 04:38:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-nuxigev8fiva" 2024/10/30 04:38:45 DEBUG : Swift container crypt path rclone-test-nuxigev8fiva: Auto set use_segments_container to true sync_test.go:626: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze' -> Encrypted drive 'TestCryptSwift:rclone-test-nuxigev8fiva' 2024/10/30 04:38:46 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nuxigev8fiva': Waiting for checks to finish 2024/10/30 04:38:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nuxigev8fiva': Waiting for transfers to finish 2024/10/30 04:38:46 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:47 DEBUG : sub dir/hello world: md5 = b515267f95c34648d52ae86f0fc5b39a OK 2024/10/30 04:38:47 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/10/30 04:38:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nuxigev8fiva': Waiting for checks to finish 2024/10/30 04:38:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nuxigev8fiva': Waiting for transfers to finish 2024/10/30 04:38:47 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-nuxigev8fiva': Purge remote 2024/10/30 04:38:47 DEBUG : Waiting for deletions to finish 2024/10/30 04:38:48 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (4.75s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:49 DEBUG : sub dir/hello world: md5 = 6631138064c1ddc8b7ec590fcde4e184 OK 2024/10/30 04:38:49 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/10/30 04:38:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:49 DEBUG : sub dir/hello world: md5 = 216a72add83fdf7caa42037c1c06c178 OK 2024/10/30 04:38:49 INFO : sub dir/hello world: Copied (replaced existing) 2024/10/30 04:38:49 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestMoveOverSelf (1.67s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:50 DEBUG : sub dir/hello world: md5 = 65b94c3fe8e83ab4a45967f518ed5a55 OK 2024/10/30 04:38:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-maredux3lufe" 2024/10/30 04:38:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-maredux3lufe.bin" 2024/10/30 04:38:51 DEBUG : Swift container crypt path rclone-test-maredux3lufe.bin: Auto set use_segments_container to true 2024/10/30 04:38:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-maredux3lufe" 2024/10/30 04:38:51 DEBUG : Swift container crypt path rclone-test-maredux3lufe: Auto set use_segments_container to true sync_test.go:671: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze' -> Encrypted drive 'TestCryptSwift:rclone-test-maredux3lufe' 2024/10/30 04:38:52 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maredux3lufe': Waiting for checks to finish 2024/10/30 04:38:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maredux3lufe': Waiting for transfers to finish 2024/10/30 04:38:52 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:53 DEBUG : sub dir/hello world: md5 = 17b1537f705297154461cc96f4d84489 OK 2024/10/30 04:38:53 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/10/30 04:38:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maredux3lufe': Waiting for checks to finish 2024/10/30 04:38:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maredux3lufe': Waiting for transfers to finish 2024/10/30 04:38:53 INFO : sub dir/hello world: Copied (server-side copy) 2024/10/30 04:38:53 INFO : sub dir/hello world: Deleted 2024/10/30 04:38:54 DEBUG : sub dir/hello world: md5 = b4571be7b470a0484318b12a53684efe OK 2024/10/30 04:38:54 DEBUG : testing file moves 2024/10/30 04:38:54 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2024/10/30 04:38:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maredux3lufe': Waiting for checks to finish 2024/10/30 04:38:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maredux3lufe': Waiting for transfers to finish 2024/10/30 04:38:55 INFO : sub dir/hello world: Copied (server-side copy) 2024/10/30 04:38:55 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-maredux3lufe': Purge remote 2024/10/30 04:38:55 DEBUG : Waiting for deletions to finish 2024/10/30 04:38:55 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (5.89s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:56 DEBUG : sub dir/hello world: md5 = b145c5db2e2afb9a77aa9c6133e6d3aa OK 2024/10/30 04:38:56 ERROR : : error listing: directory not found 2024/10/30 04:38:56 DEBUG : Local file system at /tmp/rclone401703151: Making directory 2024/10/30 04:38:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyAfterDelete (1.26s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:57 DEBUG : sub dir/hello world: md5 = a042e5e76e4bd10b2268bb499065672b OK 2024/10/30 04:38:58 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:38:58 DEBUG : Local file system at /tmp/rclone401703151: Waiting for checks to finish 2024/10/30 04:38:58 DEBUG : Local file system at /tmp/rclone401703151: Waiting for transfers to finish 2024/10/30 04:38:58 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2024/10/30 04:38:58 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyRedownload (1.27s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:59 DEBUG : check sum: Need to transfer - File not found at Destination 2024/10/30 04:38:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:59 DEBUG : check sum: md5 = ef6079fcd9debc3703b88636ab85f2b5 OK 2024/10/30 04:38:59 INFO : check sum: Copied (new) 2024/10/30 04:38:59 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:38:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:38:59 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2024/10/30 04:38:59 DEBUG : check sum: Size of src and dst objects identical 2024/10/30 04:38:59 DEBUG : check sum: Unchanged skipping 2024/10/30 04:38:59 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:38:59 DEBUG : Waiting for deletions to finish 2024/10/30 04:38:59 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncBasedOnCheckSum (1.63s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:00 DEBUG : sizeonly: Need to transfer - File not found at Destination 2024/10/30 04:39:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:01 DEBUG : sizeonly: md5 = ea4aec9839537c3e05ed9f2f5bb20a92 OK 2024/10/30 04:39:01 INFO : sizeonly: Copied (new) 2024/10/30 04:39:01 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:01 DEBUG : sizeonly: Sizes identical 2024/10/30 04:39:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:01 DEBUG : sizeonly: Unchanged skipping 2024/10/30 04:39:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:01 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:01 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncSizeOnly (1.75s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:02 DEBUG : ignore-size: Need to transfer - File not found at Destination 2024/10/30 04:39:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:02 DEBUG : ignore-size: md5 = 1c9ea64a143ae6436070953556f5f562 OK 2024/10/30 04:39:02 INFO : ignore-size: Copied (new) 2024/10/30 04:39:02 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:03 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:03 DEBUG : ignore-size: Unchanged skipping 2024/10/30 04:39:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:03 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:03 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncIgnoreSize (1.66s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:04 DEBUG : existing: md5 = 0a40fbe15745b6f6e0705edd0335b05b OK 2024/10/30 04:39:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:04 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:04 DEBUG : existing: Unchanged skipping 2024/10/30 04:39:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:04 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:04 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:04 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2024/10/30 04:39:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:04 DEBUG : existing: md5 = c2440ed1c80471b485ad6977caba1f52 OK 2024/10/30 04:39:04 INFO : existing: Copied (replaced existing) 2024/10/30 04:39:04 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (1.95s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:06 DEBUG : existing: Need to transfer - File not found at Destination 2024/10/30 04:39:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:06 DEBUG : existing: md5 = 7257097aebc5afda301dcb0699e9278b OK 2024/10/30 04:39:06 INFO : existing: Copied (new) 2024/10/30 04:39:06 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:06 DEBUG : existing: Destination exists, skipping 2024/10/30 04:39:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:06 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:06 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncIgnoreExisting (1.51s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:07 DEBUG : b/potato: md5 = 2cb0096e07e98847bfba0462a7a819f3 OK 2024/10/30 04:39:08 DEBUG : c/non empty space: md5 = ea7d3d3f3ac7fd48331183e6ec57d85a OK 2024/10/30 04:39:08 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/10/30 04:39:08 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/10/30 04:39:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:08 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:08 DEBUG : c/non empty space: Unchanged skipping 2024/10/30 04:39:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:08 DEBUG : a/potato2: md5 = 9b4efd4614e926b76a1372395ca1276c OK 2024/10/30 04:39:08 INFO : a/potato2: Copied (new) 2024/10/30 04:39:08 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:08 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncIgnoreErrors (2.53s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:10 DEBUG : empty space: md5 = 2ab3e132cd556bcbea5b7ec642ec9a0c OK 2024/10/30 04:39:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:10 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2024/10/30 04:39:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:10 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2024/10/30 04:39:10 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:10 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2024/10/30 04:39:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:11 DEBUG : empty space: md5 = a75d371ac573ce109bf2031c5c22466d OK 2024/10/30 04:39:11 INFO : empty space: Copied (replaced existing) 2024/10/30 04:39:11 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncAfterChangingModtimeOnly (2.10s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", 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-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:12 DEBUG : foo: md5 = 38a1adea02f3397d8613dafa777613e6 OK 2024/10/30 04:39:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:12 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2024/10/30 04:39:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:13 DEBUG : foo: md5 = 925d9a836a736729b1c61a13c0594d93 OK 2024/10/30 04:39:13 INFO : foo: Copied (replaced existing) 2024/10/30 04:39:13 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncDoesntUpdateModtime (1.97s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:14 DEBUG : empty space: md5 = 3b62d229ed8050407260e5d91d5bae98 OK 2024/10/30 04:39:14 DEBUG : potato: Need to transfer - File not found at Destination 2024/10/30 04:39:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:14 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:14 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:15 DEBUG : potato: md5 = 3dc3a84da9871c564c2efef8cb3867e6 OK 2024/10/30 04:39:15 INFO : potato: Copied (new) 2024/10/30 04:39:15 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncAfterAddingAFile (1.81s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:16 DEBUG : potato: md5 = 3270e285e664f8a1103a53fbed852c2d OK 2024/10/30 04:39:16 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2024/10/30 04:39:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:16 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:16 DEBUG : potato: md5 = 92fe74649432eda9be1c2eeb82c59d49 OK 2024/10/30 04:39:16 INFO : potato: Copied (replaced existing) 2024/10/30 04:39:16 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncAfterChangingFilesSizeOnly (1.26s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:17 DEBUG : potato: md5 = 241cd5772883c2b24d137ef3d690e151 OK 2024/10/30 04:39:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:17 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2024/10/30 04:39:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:17 DEBUG : potato: md5 = 066685e75111de157a2eb6622e7c47aa OK 2024/10/30 04:39:17 INFO : potato: Copied (replaced existing) 2024/10/30 04:39:17 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncAfterChangingContentsOnly (1.39s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:18 DEBUG : potato: md5 = 72e48207210764a9e8299f1db663d5e2 OK 2024/10/30 04:39:18 DEBUG : empty space: md5 = 3adffdc2c7ace701f57bcc4c868472a7 OK 2024/10/30 04:39:19 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:39:19 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2024/10/30 04:39:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:19 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:19 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:19 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:19 NOTICE: potato: Skipped delete as --dry-run is set (size 21) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (1.54s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:20 DEBUG : potato: md5 = 35c48c45eb7aa48ceda133164a721443 OK 2024/10/30 04:39:20 DEBUG : empty space: md5 = 3fc47a652dd97c35efe5baa4463be1e8 OK 2024/10/30 04:39:20 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:39:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:20 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:20 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:21 DEBUG : potato2: md5 = e96e1984074acd3c92af391629affd80 OK 2024/10/30 04:39:21 INFO : potato2: Copied (new) 2024/10/30 04:39:21 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:21 INFO : potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (2.05s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:22 DEBUG : b/potato: md5 = c2eaa88c0acafc85fadeabcd000aab31 OK 2024/10/30 04:39:22 DEBUG : c/non empty space: md5 = af8fdf6fa9a795957266d7d0c6da014b OK 2024/10/30 04:39:22 DEBUG : d: Making directory 2024/10/30 04:39:22 DEBUG : d/e: Making directory fstest.go:244: Filtering empty directory "d" fstest.go:244: Filtering empty directory "d/e" 2024/10/30 04:39:22 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/10/30 04:39:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:23 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:23 DEBUG : c/non empty space: Unchanged skipping 2024/10/30 04:39:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:23 DEBUG : a/potato2: md5 = bc37ac4b4419889c91ec3d2f329821e6 OK 2024/10/30 04:39:23 INFO : a/potato2: Copied (new) 2024/10/30 04:39:23 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:23 INFO : b/potato: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (2.26s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:25 DEBUG : b/potato: md5 = 896d73513d381e97489034316cabafcd OK 2024/10/30 04:39:25 DEBUG : c/non empty space: md5 = c91de755d0328fe8fec469d790008f7e OK 2024/10/30 04:39:25 DEBUG : d: Making directory fstest.go:244: Filtering empty directory "d" 2024/10/30 04:39:25 DEBUG : a/potato2: Need to transfer - File not found at Destination 2024/10/30 04:39:25 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:25 DEBUG : c/non empty space: Unchanged skipping 2024/10/30 04:39:25 DEBUG : a/potato2: md5 = d9d73e90be29203f8b22fcb2c3f1a22b OK 2024/10/30 04:39:25 INFO : a/potato2: Copied (new) 2024/10/30 04:39:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:25 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': not deleting files as there were IO errors 2024/10/30 04:39:25 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" fstest.go:244: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (2.40s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:27 DEBUG : potato: md5 = 3af928e5b53de0aa73e808634b152690 OK 2024/10/30 04:39:27 DEBUG : empty space: md5 = a4d123adcb59549a4e2166a6adb4238c OK 2024/10/30 04:39:27 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:27 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:39:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:27 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:27 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:27 INFO : potato: Deleted 2024/10/30 04:39:27 DEBUG : potato2: md5 = 6d68f0a043f0776a849c547e4d4ca047 OK 2024/10/30 04:39:27 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (2.08s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:29 DEBUG : potato: md5 = c78fd455189c00ddd9201d0aaf72eb2c OK 2024/10/30 04:39:29 DEBUG : empty space: md5 = 45ba3b367a60c9989576b7cbe986df43 OK 2024/10/30 04:39:29 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:29 INFO : potato: Deleted 2024/10/30 04:39:30 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:39:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:30 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:30 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:30 DEBUG : potato2: md5 = ca7d30843948dbdc220ac34db1399749 OK 2024/10/30 04:39:30 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncDeleteBefore (2.09s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:31 DEBUG : potato: md5 = 77bec96f6e8a287aa066fbb5234da47a OK 2024/10/30 04:39:31 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:39:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:31 DEBUG : potato2: md5 = 5799195cd51bae073da07f4736ffe5af OK 2024/10/30 04:39:31 INFO : potato2: Copied (new) run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestCopyDeleteBefore (1.52s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:32 DEBUG : potato2: md5 = f967ab7bc78057ab3d7e504f3344e3d5 OK 2024/10/30 04:39:32 DEBUG : empty space: md5 = 880b8b908e3994b906431f8de09f98f5 OK 2024/10/30 04:39:33 DEBUG : enormous: Excluded (Size Filter) 2024/10/30 04:39:33 DEBUG : enormous: Excluded 2024/10/30 04:39:33 DEBUG : potato2: Excluded (Size Filter) 2024/10/30 04:39:33 DEBUG : potato2: Excluded 2024/10/30 04:39:33 DEBUG : potato2: Excluded (Size Filter) 2024/10/30 04:39:33 DEBUG : potato2: Excluded 2024/10/30 04:39:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:33 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:33 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:33 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:33 DEBUG : enormous: Excluded (Size Filter) 2024/10/30 04:39:33 DEBUG : enormous: Excluded 2024/10/30 04:39:33 DEBUG : potato2: Excluded (Size Filter) 2024/10/30 04:39:33 DEBUG : potato2: Excluded 2024/10/30 04:39:33 DEBUG : potato2: Excluded (Size Filter) 2024/10/30 04:39:33 DEBUG : potato2: Excluded 2024/10/30 04:39:33 DEBUG : Local file system at /tmp/rclone401703151: Waiting for checks to finish 2024/10/30 04:39:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:33 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:33 DEBUG : Local file system at /tmp/rclone401703151: Waiting for transfers to finish 2024/10/30 04:39:33 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:33 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncWithExclude (1.99s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:34 DEBUG : potato2: md5 = 300a0a9868651a3f6b21d5719a2c3551 OK 2024/10/30 04:39:34 DEBUG : empty space: md5 = 1b709f3dfecc355b7376315ba2bc09f7 OK 2024/10/30 04:39:35 DEBUG : enormous: md5 = e38e71fddde244b3a74a388e730b6091 OK 2024/10/30 04:39:35 DEBUG : enormous: Excluded (Size Filter) 2024/10/30 04:39:35 DEBUG : enormous: Excluded 2024/10/30 04:39:35 DEBUG : potato2: Excluded (Size Filter) 2024/10/30 04:39:35 DEBUG : potato2: Excluded 2024/10/30 04:39:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:35 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:35 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:36 INFO : potato2: Deleted 2024/10/30 04:39:36 INFO : enormous: Deleted 2024/10/30 04:39:36 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:36 DEBUG : Local file system at /tmp/rclone401703151: Waiting for checks to finish 2024/10/30 04:39:36 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:36 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:36 DEBUG : Local file system at /tmp/rclone401703151: Waiting for transfers to finish 2024/10/30 04:39:36 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:36 INFO : potato2: Deleted 2024/10/30 04:39:36 INFO : enormous: Deleted 2024/10/30 04:39:36 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncWithExcludeAndDeleteExcluded (2.64s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:37 DEBUG : one: md5 = 6adc692db8886d3a7a77224850ef9ad4 OK 2024/10/30 04:39:38 DEBUG : two: md5 = 6a9a508b25823098e25ec4c58822a708 OK 2024/10/30 04:39:38 DEBUG : three: md5 = 5ed3fc3f3d46b600c305cf6427f95262 OK 2024/10/30 04:39:39 DEBUG : four: md5 = 3583ab31db1aed851c9ae3a39e3e2584 OK 2024/10/30 04:39:39 DEBUG : five: Need to transfer - File not found at Destination 2024/10/30 04:39:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:39 DEBUG : four: Sizes differ (src 4 vs dst 8) 2024/10/30 04:39:39 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2024/10/30 04:39:39 DEBUG : three: Sizes identical 2024/10/30 04:39:39 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2024/10/30 04:39:39 DEBUG : one: Destination is newer than source, skipping 2024/10/30 04:39:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:39 DEBUG : four: md5 = 7392a5727908cba748d29cad165e30f9 OK 2024/10/30 04:39:39 INFO : four: Copied (replaced existing) 2024/10/30 04:39:39 DEBUG : two: md5 = d72d27118f5d557e25ef427d15391b26 OK 2024/10/30 04:39:39 INFO : two: Copied (replaced existing) 2024/10/30 04:39:39 DEBUG : five: md5 = 899bf65ed47884637ef14064cedfdefc OK 2024/10/30 04:39:39 INFO : five: Copied (new) 2024/10/30 04:39:39 DEBUG : Waiting for deletions to finish sync_test.go:1449: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (4.26s) === 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-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" sync_test.go:1538: Can track renames: false 2024/10/30 04:39:41 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Ignoring --track-renames as the source and destination do not have a common hash 2024/10/30 04:39:41 DEBUG : potato: Need to transfer - File not found at Destination 2024/10/30 04:39:41 DEBUG : yam: Need to transfer - File not found at Destination 2024/10/30 04:39:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:41 DEBUG : potato: md5 = a0df1b6f5a605eb3f2e78c0591627d66 OK 2024/10/30 04:39:41 INFO : potato: Copied (new) 2024/10/30 04:39:41 DEBUG : yam: md5 = 117d009cc9a906cc687b0aca6e6b8efc OK 2024/10/30 04:39:41 INFO : yam: Copied (new) 2024/10/30 04:39:41 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:42 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Ignoring --track-renames as the source and destination do not have a common hash 2024/10/30 04:39:42 DEBUG : yaml: Need to transfer - File not found at Destination 2024/10/30 04:39:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:42 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:42 DEBUG : potato: Unchanged skipping 2024/10/30 04:39:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:42 DEBUG : yaml: md5 = ad3cb2ff6ff89394fb6fdc1ed6592901 OK 2024/10/30 04:39:42 INFO : yaml: Copied (new) 2024/10/30 04:39:42 DEBUG : Waiting for deletions to finish 2024/10/30 04:39:42 INFO : yam: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncWithTrackRenames (2.77s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" sync_test.go:1610: Can track renames: true 2024/10/30 04:39:44 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Making map for --track-renames 2024/10/30 04:39:44 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Finished making map for --track-renames 2024/10/30 04:39:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:44 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/10/30 04:39:44 DEBUG : yam: Need to transfer - No matching file found at Destination 2024/10/30 04:39:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for renames to finish 2024/10/30 04:39:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:44 DEBUG : yam: md5 = 52a875b4aef67b9b21664af5b2e3b0e3 OK 2024/10/30 04:39:44 INFO : yam: Copied (new) 2024/10/30 04:39:44 DEBUG : potato: md5 = 0c308b0387f03bd02416966503f728bd OK 2024/10/30 04:39:44 INFO : potato: Copied (new) 2024/10/30 04:39:44 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:44 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Making map for --track-renames 2024/10/30 04:39:44 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Finished making map for --track-renames 2024/10/30 04:39:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:44 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:44 DEBUG : potato: Unchanged skipping 2024/10/30 04:39:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for renames to finish 2024/10/30 04:39:45 INFO : yam: Copied (server-side copy) to: yaml 2024/10/30 04:39:45 INFO : yam: Deleted 2024/10/30 04:39:45 INFO : yaml: Renamed from "yam" 2024/10/30 04:39:45 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:45 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyModtime (2.07s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" sync_test.go:1649: Can track renames: true 2024/10/30 04:39:46 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Making map for --track-renames 2024/10/30 04:39:46 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Finished making map for --track-renames 2024/10/30 04:39:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:46 DEBUG : potato: Need to transfer - No matching file found at Destination 2024/10/30 04:39:46 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2024/10/30 04:39:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for renames to finish 2024/10/30 04:39:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:46 DEBUG : potato: md5 = 91ec185964d5855bd8290a096f31b11f OK 2024/10/30 04:39:46 INFO : potato: Copied (new) 2024/10/30 04:39:46 DEBUG : sub/yam: md5 = 30298318400737280881c18a81922bc5 OK 2024/10/30 04:39:46 INFO : sub/yam: Copied (new) 2024/10/30 04:39:46 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:47 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:47 DEBUG : potato: Unchanged skipping 2024/10/30 04:39:47 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Making map for --track-renames 2024/10/30 04:39:47 INFO : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Finished making map for --track-renames 2024/10/30 04:39:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for renames to finish 2024/10/30 04:39:47 INFO : sub/yam: Copied (server-side copy) to: yam 2024/10/30 04:39:47 INFO : sub/yam: Deleted 2024/10/30 04:39:47 INFO : yam: Renamed from "sub/yam" 2024/10/30 04:39:47 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:47 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncWithTrackRenamesStrategyLeaf (2.50s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:48 DEBUG : Creating backend with remote "/tmp/rclone401703151/dir1" 2024/10/30 04:39:48 DEBUG : Creating backend with remote "/tmp/rclone401703151/dir2" 2024/10/30 04:39:48 DEBUG : Local file system at /tmp/rclone401703151/dir2: Using server-side directory move 2024/10/30 04:39:48 INFO : Local file system at /tmp/rclone401703151/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/10/30 04:39:48 DEBUG : file1.txt: Need to transfer - File not found at Destination 2024/10/30 04:39:48 INFO : file1.txt: Moved (server-side) 2024/10/30 04:39:48 DEBUG : Local file system at /tmp/rclone401703151/dir2: Waiting for checks to finish 2024/10/30 04:39:48 DEBUG : Local file system at /tmp/rclone401703151/dir2: Waiting for transfers to finish --- PASS: TestServerSideMoveLocal (0.20s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:39:49 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/10/30 04:39:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:49 DEBUG : sub dir/hello world: md5 = 0d3c5ecb62a3d3549132ddfb758d69d6 OK 2024/10/30 04:39:49 INFO : sub dir/hello world: Copied (new) 2024/10/30 04:39:49 INFO : sub dir/hello world: Deleted 2024/10/30 04:39:49 DEBUG : nested/sub dir/file: md5 = b810b6c744af852cc44908769fb2d67b OK 2024/10/30 04:39:49 INFO : nested/sub dir/file: Copied (new) 2024/10/30 04:39:49 INFO : nested/sub dir/file: Deleted 2024/10/30 04:39:49 INFO : sub dir: Removing directory 2024/10/30 04:39:49 INFO : nested/sub dir: Removing directory 2024/10/30 04:39:49 INFO : nested: Removing directory 2024/10/30 04:39:49 DEBUG : Local file system at /tmp/rclone401703151: deleted 3 directories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestMoveWithDeleteEmptySrcDirs (1.40s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:50 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 04:39:50 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2024/10/30 04:39:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:50 DEBUG : nested/sub dir/file: md5 = 59ccad835cb1649d1c8583687a02b6af OK 2024/10/30 04:39:50 INFO : nested/sub dir/file: Copied (new) 2024/10/30 04:39:50 INFO : nested/sub dir/file: Deleted 2024/10/30 04:39:50 DEBUG : sub dir/hello world: md5 = f08080cb110289745f037a060a2e1ad1 OK 2024/10/30 04:39:50 INFO : sub dir/hello world: Copied (new) 2024/10/30 04:39:50 INFO : sub dir/hello world: Deleted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (1.42s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:51 DEBUG : existing: Need to transfer - File not found at Destination 2024/10/30 04:39:51 DEBUG : existing-b: Need to transfer - File not found at Destination 2024/10/30 04:39:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:52 DEBUG : existing: md5 = 41cf2fd0482f8eb295c67dba2edd034a OK 2024/10/30 04:39:52 INFO : existing: Copied (new) 2024/10/30 04:39:52 INFO : existing: Deleted 2024/10/30 04:39:52 DEBUG : existing-b: md5 = 446d0a98b1da0c986cd280b98a52f298 OK 2024/10/30 04:39:52 INFO : existing-b: Copied (new) 2024/10/30 04:39:52 INFO : existing-b: Deleted 2024/10/30 04:39:52 DEBUG : existing: Destination exists, skipping 2024/10/30 04:39:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:39:52 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2024/10/30 04:39:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:39:52 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestMoveWithIgnoreExisting (1.94s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:39:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-ticufaw6depo" 2024/10/30 04:39:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-ticufaw6depo.bin" 2024/10/30 04:39:54 DEBUG : Swift container crypt path rclone-test-ticufaw6depo.bin: Auto set use_segments_container to true 2024/10/30 04:39:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-ticufaw6depo" 2024/10/30 04:39:54 DEBUG : Swift container crypt path rclone-test-ticufaw6depo: Auto set use_segments_container to true 2024/10/30 04:39:55 DEBUG : potato2: md5 = a63870d838d115930cdbc70950a07c76 OK 2024/10/30 04:39:55 DEBUG : empty space: md5 = 5f9da3c689889826976d11cbac075f79 OK 2024/10/30 04:39:55 DEBUG : potato3: md5 = f833da86805429e6e7e4989457dd9fc4 OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze' -> Encrypted drive 'TestCryptSwift:rclone-test-ticufaw6depo' 2024/10/30 04:39:56 DEBUG : empty space: md5 = 100e4e84ca1bf8520eb02c467508ff54 OK 2024/10/30 04:39:57 DEBUG : potato3: md5 = 4138d14d558dc39f27322ab7df085e2d OK 2024/10/30 04:39:57 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:39:57 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/10/30 04:39:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-ticufaw6depo': Waiting for checks to finish 2024/10/30 04:39:57 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:39:57 DEBUG : empty space: Unchanged skipping 2024/10/30 04:39:57 INFO : potato2: Copied (server-side copy) 2024/10/30 04:39:57 INFO : empty space: Deleted 2024/10/30 04:39:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-ticufaw6depo': Waiting for transfers to finish 2024/10/30 04:39:57 INFO : potato3: Copied (server-side copy) 2024/10/30 04:39:58 INFO : potato2: Deleted 2024/10/30 04:39:58 INFO : potato3: Deleted 2024/10/30 04:39:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-sigufux4coco" 2024/10/30 04:39:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sigufux4coco.bin" 2024/10/30 04:39:59 DEBUG : Swift container crypt path rclone-test-sigufux4coco.bin: Auto set use_segments_container to true 2024/10/30 04:39:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sigufux4coco" 2024/10/30 04:39:59 DEBUG : Swift container crypt path rclone-test-sigufux4coco: Auto set use_segments_container to true 2024/10/30 04:40:00 DEBUG : empty space: Need to transfer - File not found at Destination 2024/10/30 04:40:00 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:40:00 DEBUG : potato3: Need to transfer - File not found at Destination 2024/10/30 04:40:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sigufux4coco': Waiting for checks to finish 2024/10/30 04:40:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sigufux4coco': Waiting for transfers to finish 2024/10/30 04:40:00 INFO : empty space: Copied (server-side copy) 2024/10/30 04:40:00 INFO : potato3: Copied (server-side copy) 2024/10/30 04:40:00 INFO : potato2: Copied (server-side copy) 2024/10/30 04:40:00 INFO : potato3: Deleted 2024/10/30 04:40:00 INFO : potato2: Deleted 2024/10/30 04:40:00 INFO : empty space: Deleted 2024/10/30 04:40:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sigufux4coco': Purge remote 2024/10/30 04:40:01 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:01 INFO : potato3.bin: Deleted 2024/10/30 04:40:01 INFO : empty space.bin: Deleted 2024/10/30 04:40:01 INFO : potato2.bin: Deleted 2024/10/30 04:40:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-ticufaw6depo': Purge remote 2024/10/30 04:40:01 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (8.26s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:02 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-towoluh6bohi" 2024/10/30 04:40:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-towoluh6bohi.bin" 2024/10/30 04:40:02 DEBUG : Swift container crypt path rclone-test-towoluh6bohi.bin: Auto set use_segments_container to true 2024/10/30 04:40:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-towoluh6bohi" 2024/10/30 04:40:03 DEBUG : Swift container crypt path rclone-test-towoluh6bohi: Auto set use_segments_container to true 2024/10/30 04:40:03 DEBUG : potato2: md5 = 249709f85e66a4cfda8f5b266983b33e OK 2024/10/30 04:40:03 DEBUG : empty space: md5 = c6be78b5fb8d9f89ef597889880b3a15 OK 2024/10/30 04:40:04 DEBUG : potato3: md5 = 6485fa913a447eaf91d4e24bc4e239dc OK sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze' -> Encrypted drive 'TestCryptSwift:rclone-test-towoluh6bohi' 2024/10/30 04:40:04 DEBUG : empty space: md5 = f7cc26780a6e70764a78674f4a688716 OK 2024/10/30 04:40:05 DEBUG : potato3: md5 = d6d696a92c4ab062f56cc50e6609d8dd OK 2024/10/30 04:40:06 DEBUG : empty space: Excluded (Size Filter) 2024/10/30 04:40:06 DEBUG : empty space: Excluded 2024/10/30 04:40:06 DEBUG : empty space: Excluded (Size Filter) 2024/10/30 04:40:06 DEBUG : empty space: Excluded 2024/10/30 04:40:06 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:40:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-towoluh6bohi': Waiting for checks to finish 2024/10/30 04:40:06 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/10/30 04:40:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-towoluh6bohi': Waiting for transfers to finish 2024/10/30 04:40:06 INFO : potato2: Copied (server-side copy) 2024/10/30 04:40:06 INFO : potato2: Deleted 2024/10/30 04:40:06 INFO : potato3: Copied (server-side copy) 2024/10/30 04:40:06 INFO : potato3: Deleted 2024/10/30 04:40:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-qimetus5moho" 2024/10/30 04:40:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qimetus5moho.bin" 2024/10/30 04:40:07 DEBUG : Swift container crypt path rclone-test-qimetus5moho.bin: Auto set use_segments_container to true 2024/10/30 04:40:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-qimetus5moho" 2024/10/30 04:40:08 DEBUG : Swift container crypt path rclone-test-qimetus5moho: Auto set use_segments_container to true 2024/10/30 04:40:09 DEBUG : empty space: Excluded (Size Filter) 2024/10/30 04:40:09 DEBUG : empty space: Excluded 2024/10/30 04:40:09 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:40:09 DEBUG : potato3: Need to transfer - File not found at Destination 2024/10/30 04:40:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qimetus5moho': Waiting for checks to finish 2024/10/30 04:40:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qimetus5moho': Waiting for transfers to finish 2024/10/30 04:40:09 INFO : potato2: Copied (server-side copy) 2024/10/30 04:40:09 INFO : potato2: Deleted 2024/10/30 04:40:09 INFO : potato3: Copied (server-side copy) 2024/10/30 04:40:10 INFO : potato3: Deleted 2024/10/30 04:40:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-qimetus5moho': Purge remote 2024/10/30 04:40:10 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:10 INFO : potato2.bin: Deleted 2024/10/30 04:40:10 INFO : potato3.bin: Deleted 2024/10/30 04:40:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-towoluh6bohi': Purge remote 2024/10/30 04:40:10 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:11 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (9.61s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-donobej0zawi" 2024/10/30 04:40:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-donobej0zawi.bin" 2024/10/30 04:40:11 DEBUG : Swift container crypt path rclone-test-donobej0zawi.bin: Auto set use_segments_container to true 2024/10/30 04:40:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-donobej0zawi" 2024/10/30 04:40:12 DEBUG : Swift container crypt path rclone-test-donobej0zawi: Auto set use_segments_container to true 2024/10/30 04:40:13 DEBUG : potato2: md5 = e612c901f8a3d444c580ee1e842c4f1c OK 2024/10/30 04:40:13 DEBUG : empty space: md5 = ad25ee9b36e1dc2d179f1efc54cea011 OK 2024/10/30 04:40:13 DEBUG : potato3: md5 = 4dfff7fd0663fefb34af3b3923ab66f9 OK 2024/10/30 04:40:13 DEBUG : tomatoDir: Making directory sync_test.go:1705: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze' -> Encrypted drive 'TestCryptSwift:rclone-test-donobej0zawi' 2024/10/30 04:40:14 DEBUG : empty space: md5 = d1643ca2e4bc2552af91e6e3f9755edc OK 2024/10/30 04:40:14 DEBUG : potato3: md5 = caa454a392a000ac4153f09d5b4afa00 OK 2024/10/30 04:40:14 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:40:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-donobej0zawi': Waiting for checks to finish 2024/10/30 04:40:14 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2024/10/30 04:40:15 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:15 DEBUG : empty space: Unchanged skipping 2024/10/30 04:40:15 INFO : empty space: Deleted 2024/10/30 04:40:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-donobej0zawi': Waiting for transfers to finish 2024/10/30 04:40:15 INFO : potato2: Copied (server-side copy) 2024/10/30 04:40:15 INFO : potato3: Copied (server-side copy) 2024/10/30 04:40:15 INFO : potato2: Deleted 2024/10/30 04:40:15 INFO : potato3: Deleted 2024/10/30 04:40:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-cedizaw1wavi" 2024/10/30 04:40:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-cedizaw1wavi.bin" 2024/10/30 04:40:16 DEBUG : Swift container crypt path rclone-test-cedizaw1wavi.bin: Auto set use_segments_container to true 2024/10/30 04:40:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-cedizaw1wavi" 2024/10/30 04:40:16 DEBUG : Swift container crypt path rclone-test-cedizaw1wavi: Auto set use_segments_container to true 2024/10/30 04:40:17 DEBUG : tomatoDir: Making directory 2024/10/30 04:40:17 DEBUG : empty space: Need to transfer - File not found at Destination 2024/10/30 04:40:17 DEBUG : potato2: Need to transfer - File not found at Destination 2024/10/30 04:40:17 DEBUG : potato3: Need to transfer - File not found at Destination 2024/10/30 04:40:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-cedizaw1wavi': Waiting for checks to finish 2024/10/30 04:40:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-cedizaw1wavi': Waiting for transfers to finish 2024/10/30 04:40:17 INFO : potato2: Copied (server-side copy) 2024/10/30 04:40:18 INFO : potato2: Deleted 2024/10/30 04:40:18 INFO : empty space: Copied (server-side copy) 2024/10/30 04:40:18 INFO : potato3: Copied (server-side copy) 2024/10/30 04:40:18 INFO : potato3: Deleted 2024/10/30 04:40:18 INFO : empty space: Deleted 2024/10/30 04:40:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-cedizaw1wavi': Purge remote 2024/10/30 04:40:19 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:19 INFO : empty space.bin: Deleted 2024/10/30 04:40:19 INFO : potato3.bin: Deleted 2024/10/30 04:40:19 INFO : potato2.bin: Deleted 2024/10/30 04:40:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-donobej0zawi': Purge remote 2024/10/30 04:40:19 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (7.99s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:19 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/rclone-move-test" 2024/10/30 04:40:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-move-test.bin" 2024/10/30 04:40:19 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-move-test.bin: Auto set use_segments_container to true 2024/10/30 04:40:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-move-test" 2024/10/30 04:40:20 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-move-test: Auto set use_segments_container to true 2024/10/30 04:40:21 DEBUG : potato2: md5 = 8e585ece0747958eb9a6168b880ef30b OK --- PASS: TestServerSideMoveOverlap (2.40s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:22 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test" 2024/10/30 04:40:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-sync-test.bin" 2024/10/30 04:40:22 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-sync-test.bin: Auto set use_segments_container to true 2024/10/30 04:40:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-sync-test" 2024/10/30 04:40:22 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-sync-test: Auto set use_segments_container to true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncOverlap (1.80s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:23 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test" 2024/10/30 04:40:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-sync-test.bin" 2024/10/30 04:40:24 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-sync-test.bin: Auto set use_segments_container to true 2024/10/30 04:40:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-sync-test" 2024/10/30 04:40:24 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-sync-test: Auto set use_segments_container to true 2024/10/30 04:40:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test-include/layer2" 2024/10/30 04:40:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-sync-test-include/layer2.bin" 2024/10/30 04:40:25 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2024/10/30 04:40:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-sync-test-include/layer2" 2024/10/30 04:40:25 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2024/10/30 04:40:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test-ignore-file" 2024/10/30 04:40:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-sync-test-ignore-file.bin" 2024/10/30 04:40:26 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2024/10/30 04:40:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/rclone-sync-test-ignore-file" 2024/10/30 04:40:27 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2024/10/30 04:40:28 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = 4cec99e31206b79a4a015f06283e15e9 OK 2024/10/30 04:40:28 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/10/30 04:40:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test': Waiting for checks to finish 2024/10/30 04:40:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test': Waiting for transfers to finish 2024/10/30 04:40:28 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:28 INFO : There was nothing to transfer 2024/10/30 04:40:28 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/10/30 04:40:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:40:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:40:28 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:28 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:29 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/10/30 04:40:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test-include/layer2': Waiting for checks to finish 2024/10/30 04:40:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test-include/layer2': Waiting for transfers to finish 2024/10/30 04:40:29 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:29 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:29 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/10/30 04:40:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:40:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:40:29 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:29 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:29 DEBUG : : Excluded 2024/10/30 04:40:29 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/10/30 04:40:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test-ignore-file': Waiting for checks to finish 2024/10/30 04:40:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/rclone-sync-test-ignore-file': Waiting for transfers to finish 2024/10/30 04:40:29 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:29 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncOverlapWithFilter (10.36s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:34 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/dst" 2024/10/30 04:40:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst.bin" 2024/10/30 04:40:34 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst.bin: Auto set use_segments_container to true 2024/10/30 04:40:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst" 2024/10/30 04:40:35 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst: Auto set use_segments_container to true 2024/10/30 04:40:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/CompareDest" 2024/10/30 04:40:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/CompareDest.bin" 2024/10/30 04:40:35 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/CompareDest.bin: Auto set use_segments_container to true 2024/10/30 04:40:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/CompareDest" 2024/10/30 04:40:36 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/CompareDest: Auto set use_segments_container to true 2024/10/30 04:40:37 DEBUG : one: Need to transfer - File not found at Destination 2024/10/30 04:40:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:40:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:40:37 DEBUG : one: md5 = 0d1ad9bdc1701a78f0126d7c52e7a4bd OK 2024/10/30 04:40:37 INFO : one: Copied (new) 2024/10/30 04:40:37 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:38 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 04:40:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:40:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:40:38 DEBUG : one: md5 = 221ab1fa27c6181ffabb2f7e7fa34335 OK 2024/10/30 04:40:38 INFO : one: Copied (replaced existing) 2024/10/30 04:40:38 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:38 DEBUG : dst/one: md5 = 7089f343164ed81ffa8c9565b8c1b4d0 OK 2024/10/30 04:40:39 DEBUG : CompareDest/one: md5 = f57b29ac081aeef11ba56cae177815de OK 2024/10/30 04:40:39 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 04:40:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:40:39 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:39 DEBUG : one: Destination found in --compare-dest, skipping 2024/10/30 04:40:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:40:39 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:39 INFO : There was nothing to transfer 2024/10/30 04:40:40 DEBUG : CompareDest/two: md5 = 9ffbeebb215ba5a4a5008d418aa65575 OK 2024/10/30 04:40:40 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:40 DEBUG : two: Destination found in --compare-dest, skipping 2024/10/30 04:40:40 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 04:40:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:40:40 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:40 DEBUG : one: Destination found in --compare-dest, skipping 2024/10/30 04:40:40 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:40:40 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:40 INFO : There was nothing to transfer 2024/10/30 04:40:41 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:41 DEBUG : two: Destination found in --compare-dest, skipping 2024/10/30 04:40:41 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 04:40:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:40:41 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:41 DEBUG : one: Destination found in --compare-dest, skipping 2024/10/30 04:40:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:40:41 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:41 INFO : There was nothing to transfer sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test 2024/10/30 04:40:41 DEBUG : two: Sizes differ (src 5 vs dst 3) 2024/10/30 04:40:41 DEBUG : two: Need to transfer - File not found at Destination 2024/10/30 04:40:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:40:41 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 04:40:41 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:41 DEBUG : one: Destination found in --compare-dest, skipping 2024/10/30 04:40:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:40:41 DEBUG : two: md5 = be51a023ad5dea802a9bafc4c76886cd OK 2024/10/30 04:40:41 INFO : two: Copied (new) 2024/10/30 04:40:41 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (9.05s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:43 DEBUG : pre-dest1/1: md5 = 606bcfe924ce7558e89ba9dc4ee66e1e OK 2024/10/30 04:40:43 DEBUG : pre-dest2/2: md5 = 1c687d2fec862fffc0da020f107aa3b2 OK 2024/10/30 04:40:44 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/dest" 2024/10/30 04:40:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dest.bin" 2024/10/30 04:40:44 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dest.bin: Auto set use_segments_container to true 2024/10/30 04:40:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dest" 2024/10/30 04:40:45 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dest: Auto set use_segments_container to true 2024/10/30 04:40:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/pre-dest1" 2024/10/30 04:40:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/pre-dest1.bin" 2024/10/30 04:40:45 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/pre-dest1.bin: Auto set use_segments_container to true 2024/10/30 04:40:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/pre-dest1" 2024/10/30 04:40:46 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/pre-dest1: Auto set use_segments_container to true 2024/10/30 04:40:46 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/pre-dest2" 2024/10/30 04:40:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/pre-dest2.bin" 2024/10/30 04:40:47 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/pre-dest2.bin: Auto set use_segments_container to true 2024/10/30 04:40:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/pre-dest2" 2024/10/30 04:40:47 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/pre-dest2: Auto set use_segments_container to true 2024/10/30 04:40:48 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:48 DEBUG : 1: Destination found in --compare-dest, skipping 2024/10/30 04:40:48 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:48 DEBUG : 2: Destination found in --compare-dest, skipping 2024/10/30 04:40:48 DEBUG : 3: Need to transfer - File not found at Destination 2024/10/30 04:40:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dest': Waiting for checks to finish 2024/10/30 04:40:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dest': Waiting for transfers to finish 2024/10/30 04:40:48 DEBUG : 3: md5 = 1302a252b94ba1975812cae515ed891d OK 2024/10/30 04:40:48 INFO : 3: Copied (new) 2024/10/30 04:40:48 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (6.95s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:40:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/dst" 2024/10/30 04:40:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst.bin" 2024/10/30 04:40:50 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst.bin: Auto set use_segments_container to true 2024/10/30 04:40:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst" 2024/10/30 04:40:50 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst: Auto set use_segments_container to true 2024/10/30 04:40:51 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/CopyDest" 2024/10/30 04:40:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/CopyDest.bin" 2024/10/30 04:40:51 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/CopyDest.bin: Auto set use_segments_container to true 2024/10/30 04:40:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/CopyDest" 2024/10/30 04:40:52 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/CopyDest: Auto set use_segments_container to true 2024/10/30 04:40:52 DEBUG : one: Need to transfer - File not found at Destination 2024/10/30 04:40:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:40:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:40:52 DEBUG : one: md5 = 072e81dc8ad71b7f1b5594839ffb6f01 OK 2024/10/30 04:40:52 INFO : one: Copied (new) 2024/10/30 04:40:52 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:40:53 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 04:40:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:40:53 DEBUG : one: md5 = d89cea6af0f876f4ccc5d21941a374ad OK 2024/10/30 04:40:53 INFO : one: Copied (replaced existing) 2024/10/30 04:40:53 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:55 DEBUG : dst/one: md5 = 449ab764be3f7e87e49672b0a301ff09 OK 2024/10/30 04:40:55 DEBUG : CopyDest/one: md5 = e19798465a091262e3a11f16bb884d73 OK 2024/10/30 04:40:55 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/BackupDir" 2024/10/30 04:40:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/BackupDir.bin" 2024/10/30 04:40:56 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/BackupDir.bin: Auto set use_segments_container to true 2024/10/30 04:40:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/BackupDir" 2024/10/30 04:40:56 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/BackupDir: Auto set use_segments_container to true 2024/10/30 04:40:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:40:57 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 04:40:57 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:40:57 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 04:40:58 INFO : one: Copied (server-side copy) 2024/10/30 04:40:58 INFO : one: Deleted 2024/10/30 04:40:58 INFO : one: Copied (server-side copy) 2024/10/30 04:40:58 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/10/30 04:40:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:40:58 DEBUG : Waiting for deletions to finish 2024/10/30 04:40:59 DEBUG : CopyDest/two: md5 = 6f4d29a020d5b25ac9cd952cc4e6eedb OK 2024/10/30 04:41:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:00 INFO : two: Copied (server-side copy) 2024/10/30 04:41:00 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/10/30 04:41:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:00 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:00 DEBUG : one: Unchanged skipping 2024/10/30 04:41:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:00 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:01 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:01 DEBUG : one: Unchanged skipping 2024/10/30 04:41:01 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:01 DEBUG : two: Unchanged skipping 2024/10/30 04:41:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:01 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:01 INFO : There was nothing to transfer 2024/10/30 04:41:02 DEBUG : CopyDest/three: md5 = 85ac5dd7dae7be736bea5af24603f61d OK 2024/10/30 04:41:03 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/10/30 04:41:03 DEBUG : three: Destination not found in --copy-dest 2024/10/30 04:41:03 DEBUG : three: Need to transfer - File not found at Destination 2024/10/30 04:41:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:03 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:03 DEBUG : one: Unchanged skipping 2024/10/30 04:41:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:03 DEBUG : two: Unchanged skipping 2024/10/30 04:41:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:03 DEBUG : three: md5 = c5ec21b732b7abd0b90fbbca0884c800 OK 2024/10/30 04:41:03 INFO : three: Copied (new) 2024/10/30 04:41:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (15.85s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:06 DEBUG : dst/one: md5 = ec3e608dba4d220b5b7eb0a666e1d913 OK 2024/10/30 04:41:06 DEBUG : dst/two: md5 = f5671b6857f17fda05b680b7f42ea000 OK 2024/10/30 04:41:06 DEBUG : dst/three.txt: md5 = 2a1d0ca6721cd6fc8cb33bd7ea8e3b3b OK 2024/10/30 04:41:06 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst.bin" 2024/10/30 04:41:07 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst.bin: Auto set use_segments_container to true 2024/10/30 04:41:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:07 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst: Auto set use_segments_container to true 2024/10/30 04:41:07 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/backup" 2024/10/30 04:41:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/backup.bin" 2024/10/30 04:41:08 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/backup.bin: Auto set use_segments_container to true 2024/10/30 04:41:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/backup" 2024/10/30 04:41:08 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/backup: Auto set use_segments_container to true 2024/10/30 04:41:09 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/10/30 04:41:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:09 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:09 DEBUG : two: Unchanged skipping 2024/10/30 04:41:10 INFO : one: Copied (server-side copy) 2024/10/30 04:41:10 INFO : one: Deleted 2024/10/30 04:41:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:10 DEBUG : one: md5 = 3d75de48f3fad8f9c19dccb7cdb22ff1 OK 2024/10/30 04:41:10 INFO : one: Copied (new) 2024/10/30 04:41:10 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:11 INFO : three.txt: Copied (server-side copy) 2024/10/30 04:41:11 INFO : three.txt: Deleted 2024/10/30 04:41:11 INFO : three.txt: Moved into backup dir 2024/10/30 04:41:12 DEBUG : dst/three.txt: md5 = 48ebca5bc9ba86e55d030ca05273c2b6 OK 2024/10/30 04:41:12 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/10/30 04:41:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:12 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:12 DEBUG : two: Unchanged skipping 2024/10/30 04:41:13 INFO : one: Copied (server-side copy) 2024/10/30 04:41:13 INFO : one: Deleted 2024/10/30 04:41:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:13 DEBUG : one: md5 = a99ede562c21efc7d67f15a22fa3c448 OK 2024/10/30 04:41:13 INFO : one: Copied (new) 2024/10/30 04:41:13 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:13 INFO : three.txt: Copied (server-side copy) 2024/10/30 04:41:13 INFO : three.txt: Deleted 2024/10/30 04:41:13 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (8.73s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:14 DEBUG : dst/one: md5 = 484123fd948923bf45e7cef6e74a4c4e OK 2024/10/30 04:41:15 DEBUG : dst/two: md5 = 8732288dbaccd70bfda9fc957b49aa3a OK 2024/10/30 04:41:15 DEBUG : dst/three.txt: md5 = 82c1bb6ad06e097d3a67e2fb3aa096b0 OK 2024/10/30 04:41:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst.bin" 2024/10/30 04:41:15 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst.bin: Auto set use_segments_container to true 2024/10/30 04:41:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:16 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst: Auto set use_segments_container to true 2024/10/30 04:41:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/backup" 2024/10/30 04:41:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/backup.bin" 2024/10/30 04:41:16 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/backup.bin: Auto set use_segments_container to true 2024/10/30 04:41:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/backup" 2024/10/30 04:41:17 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/backup: Auto set use_segments_container to true 2024/10/30 04:41:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/10/30 04:41:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:17 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:17 DEBUG : two: Unchanged skipping 2024/10/30 04:41:18 INFO : one: Copied (server-side copy) to: one.bak 2024/10/30 04:41:18 INFO : one: Deleted 2024/10/30 04:41:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:18 DEBUG : one: md5 = 97fcc8106d83a77c64eb15295de256d3 OK 2024/10/30 04:41:18 INFO : one: Copied (new) 2024/10/30 04:41:18 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:19 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/10/30 04:41:19 INFO : three.txt: Deleted 2024/10/30 04:41:19 INFO : three.txt: Moved into backup dir 2024/10/30 04:41:19 DEBUG : dst/three.txt: md5 = 244cb0b479535320b06b983cb35b8136 OK 2024/10/30 04:41:20 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/10/30 04:41:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:20 DEBUG : two: Unchanged skipping 2024/10/30 04:41:20 INFO : one: Copied (server-side copy) to: one.bak 2024/10/30 04:41:20 INFO : one: Deleted 2024/10/30 04:41:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:20 DEBUG : one: md5 = b871a0692f40298c50ad837af536dfec OK 2024/10/30 04:41:20 INFO : one: Copied (new) 2024/10/30 04:41:20 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:21 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/10/30 04:41:21 INFO : three.txt: Deleted 2024/10/30 04:41:21 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (7.83s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:22 DEBUG : dst/one: md5 = c87e8e7a9852bddbbdfc10bbae353ae1 OK 2024/10/30 04:41:22 DEBUG : dst/two: md5 = d3342587e3daae8a01a015c4499699da OK 2024/10/30 04:41:23 DEBUG : dst/three.txt: md5 = 133db2371420959b772d4914041ec9c2 OK 2024/10/30 04:41:23 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst.bin" 2024/10/30 04:41:23 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst.bin: Auto set use_segments_container to true 2024/10/30 04:41:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:24 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst: Auto set use_segments_container to true 2024/10/30 04:41:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/backup" 2024/10/30 04:41:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/backup.bin" 2024/10/30 04:41:24 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/backup.bin: Auto set use_segments_container to true 2024/10/30 04:41:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/backup" 2024/10/30 04:41:25 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/backup: Auto set use_segments_container to true 2024/10/30 04:41:25 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/10/30 04:41:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:25 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:25 DEBUG : two: Unchanged skipping 2024/10/30 04:41:26 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/10/30 04:41:26 INFO : one: Deleted 2024/10/30 04:41:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:26 DEBUG : one: md5 = 8a13d9d8ab2ff04ae8e0fd71344e3a31 OK 2024/10/30 04:41:26 INFO : one: Copied (new) 2024/10/30 04:41:26 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:27 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/10/30 04:41:27 INFO : three.txt: Deleted 2024/10/30 04:41:27 INFO : three.txt: Moved into backup dir 2024/10/30 04:41:28 DEBUG : dst/three.txt: md5 = 67bb1de74dc5d0ac80e4a227de16c56c OK 2024/10/30 04:41:28 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/10/30 04:41:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:28 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:28 DEBUG : two: Unchanged skipping 2024/10/30 04:41:29 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/10/30 04:41:29 INFO : one: Deleted 2024/10/30 04:41:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:29 DEBUG : one: md5 = dbe7280d3e8e0c4652aa95d7a1b491d7 OK 2024/10/30 04:41:29 INFO : one: Copied (new) 2024/10/30 04:41:29 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:30 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/10/30 04:41:30 INFO : three.txt: Deleted 2024/10/30 04:41:30 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (9.09s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:31 DEBUG : dst/one: md5 = d0a617b8f2d8398a4bd264de8c8810d6 OK 2024/10/30 04:41:31 DEBUG : dst/two: md5 = 0e5f40d836f0fd7a3f29d212f32c8570 OK 2024/10/30 04:41:32 DEBUG : dst/three.txt: md5 = 669485dc954bcb3eaa029d24fe98471b OK 2024/10/30 04:41:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst.bin" 2024/10/30 04:41:32 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst.bin: Auto set use_segments_container to true 2024/10/30 04:41:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:33 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst: Auto set use_segments_container to true 2024/10/30 04:41:33 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/10/30 04:41:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:33 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:33 DEBUG : two: Unchanged skipping 2024/10/30 04:41:34 INFO : one: Copied (server-side copy) to: one.bak 2024/10/30 04:41:34 INFO : one: Deleted 2024/10/30 04:41:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:34 DEBUG : one: md5 = 80287cc870387b4d7950884859d84cfd OK 2024/10/30 04:41:34 INFO : one: Copied (new) 2024/10/30 04:41:34 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:35 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/10/30 04:41:35 INFO : three.txt: Deleted 2024/10/30 04:41:35 INFO : three.txt: Moved into backup dir 2024/10/30 04:41:35 DEBUG : dst/three.txt: md5 = 48c076aa0fdc9379020a1a802a6040ad OK 2024/10/30 04:41:36 DEBUG : one.bak: Excluded (Path Filter) 2024/10/30 04:41:36 DEBUG : one.bak: Excluded 2024/10/30 04:41:36 DEBUG : three.txt.bak: Excluded (Path Filter) 2024/10/30 04:41:36 DEBUG : three.txt.bak: Excluded 2024/10/30 04:41:36 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/10/30 04:41:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for checks to finish 2024/10/30 04:41:36 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:36 DEBUG : two: Unchanged skipping 2024/10/30 04:41:36 INFO : one: Copied (server-side copy) to: one.bak 2024/10/30 04:41:36 INFO : one: Deleted 2024/10/30 04:41:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze/dst': Waiting for transfers to finish 2024/10/30 04:41:36 DEBUG : one: md5 = ab84243a42f876fb9f7a9cd6b95a68f8 OK 2024/10/30 04:41:36 INFO : one: Copied (new) 2024/10/30 04:41:36 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:37 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/10/30 04:41:37 INFO : three.txt: Deleted 2024/10/30 04:41:37 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (6.85s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:38 DEBUG : dst/one: md5 = 891e7f24c7065545bd65aacf8b390040 OK 2024/10/30 04:41:38 DEBUG : dst/two: md5 = 9d305ab18e2cc1ecea37fa7c67b3d49d OK 2024/10/30 04:41:38 DEBUG : dst/three.txt: md5 = e660b5282965a4f7d0c5ac9fde776580 OK 2024/10/30 04:41:39 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst.bin" 2024/10/30 04:41:39 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst.bin: Auto set use_segments_container to true 2024/10/30 04:41:39 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:40 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst: Auto set use_segments_container to true 2024/10/30 04:41:40 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/10/30 04:41:40 INFO : one: Copied (server-side copy) to: one.bak 2024/10/30 04:41:40 INFO : one: Deleted 2024/10/30 04:41:40 DEBUG : one: md5 = efa84daf1c9255247355ae2f57dbf9f9 OK 2024/10/30 04:41:40 INFO : one: Copied (new) 2024/10/30 04:41:40 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:40 DEBUG : two: Unchanged skipping 2024/10/30 04:41:40 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/10/30 04:41:41 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/10/30 04:41:41 INFO : three.txt: Deleted 2024/10/30 04:41:41 DEBUG : three.txt: md5 = 660159ff5e17f62d367d636ba7e4ba22 OK 2024/10/30 04:41:41 INFO : three.txt: Copied (new) 2024/10/30 04:41:42 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/10/30 04:41:42 INFO : one: Copied (server-side copy) to: one.bak 2024/10/30 04:41:42 INFO : one: Deleted 2024/10/30 04:41:42 DEBUG : one: md5 = 5a054ad8aacee723b763f6248bbe6f78 OK 2024/10/30 04:41:42 INFO : one: Copied (new) 2024/10/30 04:41:42 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:42 DEBUG : two: Unchanged skipping 2024/10/30 04:41:42 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/10/30 04:41:43 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2024/10/30 04:41:43 INFO : three.txt: Deleted 2024/10/30 04:41:43 DEBUG : three.txt: md5 = b0cc8c88b89b8a78693d73cc9f9d1059 OK 2024/10/30 04:41:43 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (6.33s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:45 DEBUG : dst/one: md5 = b7e146fa6bb3f9e2ba69cf3a3f96ca53 OK 2024/10/30 04:41:45 DEBUG : dst/two: md5 = af6c8d0783037298f7402a7b86882abb OK 2024/10/30 04:41:45 DEBUG : dst/three.txt: md5 = 446997300d431cfc2ee4375b3b3fce47 OK 2024/10/30 04:41:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst.bin" 2024/10/30 04:41:46 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst.bin: Auto set use_segments_container to true 2024/10/30 04:41:46 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wuzodal5kaze/dst" 2024/10/30 04:41:46 DEBUG : Swift container crypt path rclone-test-wuzodal5kaze/dst: Auto set use_segments_container to true 2024/10/30 04:41:46 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/10/30 04:41:47 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/10/30 04:41:48 INFO : one: Deleted 2024/10/30 04:41:48 DEBUG : one: md5 = 5d198a72180c01081ac893c61552e671 OK 2024/10/30 04:41:48 INFO : one: Copied (new) 2024/10/30 04:41:48 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:48 DEBUG : two: Unchanged skipping 2024/10/30 04:41:48 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2024/10/30 04:41:49 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/10/30 04:41:49 INFO : three.txt: Deleted 2024/10/30 04:41:49 DEBUG : three.txt: md5 = b8d0744a5002af3d03ffae2d60de1ed6 OK 2024/10/30 04:41:49 INFO : three.txt: Copied (new) 2024/10/30 04:41:50 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/10/30 04:41:50 INFO : one: Copied (server-side copy) to: one-2019-01-01 2024/10/30 04:41:51 INFO : one: Deleted 2024/10/30 04:41:51 DEBUG : one: md5 = bf298345ca74522fb9445079bde10759 OK 2024/10/30 04:41:51 INFO : one: Copied (new) 2024/10/30 04:41:51 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:51 DEBUG : two: Unchanged skipping 2024/10/30 04:41:51 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2024/10/30 04:41:51 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2024/10/30 04:41:51 INFO : three.txt: Deleted 2024/10/30 04:41:51 DEBUG : three.txt: md5 = 09ada7361a73cdbb41e757796ceb5f1a OK 2024/10/30 04:41:51 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (8.47s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:53 DEBUG : Testêé: md5 = ed2b067cad687f527134bc4161abb425 OK 2024/10/30 04:41:54 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2024/10/30 04:41:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:41:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:41:54 DEBUG : Testêé: md5 = d017f669a5a4f8f88ad91ff22e6dad26 OK 2024/10/30 04:41:54 INFO : Testêé: Copied (replaced existing) to: Testêé 2024/10/30 04:41:54 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (1.45s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:54 DEBUG : existing: Need to transfer - File not found at Destination 2024/10/30 04:41:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:41:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:41:55 DEBUG : existing: md5 = 0014a21906ad8aa407bf803b5b4ebfbe OK 2024/10/30 04:41:55 INFO : existing: Copied (new) 2024/10/30 04:41:55 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:55 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2024/10/30 04:41:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:41:55 ERROR : existing: Source and destination exist but do not match: immutable file modified 2024/10/30 04:41:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:41:55 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': not deleting files as there were IO errors 2024/10/30 04:41:55 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': not deleting directories as there were IO errors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncImmutable (1.63s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:56 DEBUG : EXISTING: md5 = b8e3b365d3556e43e7ae16e436298792 OK 2024/10/30 04:41:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:41:57 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:41:57 DEBUG : existing: Unchanged skipping 2024/10/30 04:41:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:41:57 DEBUG : Waiting for deletions to finish 2024/10/30 04:41:57 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.30s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.20s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", 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-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", 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-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (0.54s) --- SKIP: TestMaxTransfer/Hard (0.17s) --- SKIP: TestMaxTransfer/Soft (0.18s) --- SKIP: TestMaxTransfer/Cautious (0.20s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:41:58 DEBUG : both0: md5 = af10859eea4f29cbac86e03098329b28 OK 2024/10/30 04:41:59 DEBUG : only0: md5 = a8a9895a3f396739d9abc1d1c666c0c4 OK 2024/10/30 04:41:59 DEBUG : both1: md5 = 8165158b8279ed033478d7b39a684f7a OK 2024/10/30 04:41:59 DEBUG : only1: md5 = 9553bf031b48d09863049808eb7fd5af OK 2024/10/30 04:42:00 DEBUG : both2: md5 = ddeedc9a433e586d159458d6f5809bed OK 2024/10/30 04:42:00 DEBUG : only2: md5 = d961d78e6138acc8de5c2918d25dce76 OK 2024/10/30 04:42:01 DEBUG : both3: md5 = 314265569bba58b440f2bfb9df2959fe OK 2024/10/30 04:42:01 DEBUG : only3: md5 = df3253d1de5a88c67c8a1079747de7bb OK 2024/10/30 04:42:02 DEBUG : both4: md5 = 4a41bfba0d2dc6558542064e978944ac OK 2024/10/30 04:42:02 DEBUG : only4: md5 = e47dc54c70432cecba04562a8dc45659 OK 2024/10/30 04:42:03 DEBUG : both5: md5 = 11cc5bd9877108bf7df6565466ad207d OK 2024/10/30 04:42:03 DEBUG : only5: md5 = 273c15ecb32a241a01f620b76fb58a01 OK 2024/10/30 04:42:04 DEBUG : both6: md5 = 2e13a066ffa7eaa7b4a6022d1df69d42 OK 2024/10/30 04:42:04 DEBUG : only6: md5 = 6427f80cbd70c5150f088238ff042220 OK 2024/10/30 04:42:04 DEBUG : both7: md5 = c1ef5cb187ba2852f44cb9c9637f32c8 OK 2024/10/30 04:42:05 DEBUG : only7: md5 = 868438210b44f64d6fb30a415abc758e OK 2024/10/30 04:42:05 DEBUG : both8: md5 = 1c3ef6e62ba9187121603813b6dbac3b OK 2024/10/30 04:42:06 DEBUG : only8: md5 = 500ff1271596e778b210428e6aaad440 OK 2024/10/30 04:42:06 DEBUG : both9: md5 = 1dd050d319c98bd8f418516faa0d7aed OK 2024/10/30 04:42:07 DEBUG : only9: md5 = 9a6fb9ec13c27eb64530084af9e3df4c OK 2024/10/30 04:42:07 DEBUG : both10: md5 = 9b7244e60b0031ece12381d04b3d64c5 OK 2024/10/30 04:42:08 DEBUG : only10: md5 = 9b88177c356673da19a77baf8a59375a OK 2024/10/30 04:42:09 DEBUG : both11: md5 = 4a21139471ef907162c16094f7c614ba OK 2024/10/30 04:42:09 DEBUG : only11: md5 = 7c153b0339eb8b10c88983d6c3fc7159 OK 2024/10/30 04:42:09 DEBUG : both12: md5 = d3aab2137bd5158605efb7dd82a9ee76 OK 2024/10/30 04:42:10 DEBUG : only12: md5 = 63dffb4992837e51dc653e6953178bd8 OK 2024/10/30 04:42:10 DEBUG : both13: md5 = 067ef8ce4f235c20543ca34fd26f9e99 OK 2024/10/30 04:42:11 DEBUG : only13: md5 = b82d058a2fb71c5de0149fa135da0997 OK 2024/10/30 04:42:11 DEBUG : both14: md5 = 2bb4dc19802a9165b6855c2d0b53203f OK 2024/10/30 04:42:14 DEBUG : only14: md5 = 14b5a51112910ee185dd71d15f8e056b OK 2024/10/30 04:42:14 DEBUG : both15: md5 = d20393c8da80ec4df1bc812ebb23d683 OK 2024/10/30 04:42:14 DEBUG : only15: md5 = ef948064856a6f7d4fdeb741779ba140 OK 2024/10/30 04:42:15 DEBUG : both16: md5 = 9d858e9ffd78ff67238fde2353679c96 OK 2024/10/30 04:42:15 DEBUG : only16: md5 = e79da1f11b825be507c5e25a04bd8f60 OK 2024/10/30 04:42:16 DEBUG : both17: md5 = 66d9ec259b0986b0dcb474e14f86602f OK 2024/10/30 04:42:16 DEBUG : only17: md5 = 21f6969a6e89537a2dad631c38d45318 OK 2024/10/30 04:42:16 DEBUG : both18: md5 = 55314e2a473c605d3353a4f502760c0f OK 2024/10/30 04:42:17 DEBUG : only18: md5 = 42d1d148ac94637b65265089730a239c OK 2024/10/30 04:42:17 DEBUG : both19: md5 = 67fc865899dfe422bfe9ae1ff75164c9 OK 2024/10/30 04:42:18 DEBUG : only19: md5 = ec46ee2619615c706480ea0563d9415a OK 2024/10/30 04:42:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:42:20 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both0: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both1: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both11: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both10: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both12: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both13: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both14: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both15: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both16: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both17: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both18: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both19: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both4: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both3: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both2: Unchanged skipping 2024/10/30 04:42:20 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:20 DEBUG : both5: Unchanged skipping 2024/10/30 04:42:21 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:21 DEBUG : both6: Unchanged skipping 2024/10/30 04:42:21 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:21 DEBUG : both7: Unchanged skipping 2024/10/30 04:42:21 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:21 DEBUG : both8: Unchanged skipping 2024/10/30 04:42:21 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:21 DEBUG : both9: Unchanged skipping 2024/10/30 04:42:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:42:21 DEBUG : Waiting for deletions to finish 2024/10/30 04:42:21 INFO : only6: Deleted 2024/10/30 04:42:21 INFO : only2: Deleted 2024/10/30 04:42:21 INFO : only4: Deleted 2024/10/30 04:42:21 INFO : only7: Deleted 2024/10/30 04:42:21 INFO : only17: Deleted 2024/10/30 04:42:21 INFO : only5: Deleted 2024/10/30 04:42:21 INFO : only8: Deleted 2024/10/30 04:42:21 INFO : only10: Deleted 2024/10/30 04:42:21 INFO : only18: Deleted 2024/10/30 04:42:21 INFO : only3: Deleted 2024/10/30 04:42:21 INFO : only15: Deleted 2024/10/30 04:42:21 INFO : only13: Deleted 2024/10/30 04:42:21 INFO : only14: Deleted 2024/10/30 04:42:21 INFO : only1: Deleted 2024/10/30 04:42:21 INFO : only12: Deleted 2024/10/30 04:42:21 INFO : only16: Deleted 2024/10/30 04:42:21 INFO : only19: Deleted 2024/10/30 04:42:21 INFO : only0: Deleted 2024/10/30 04:42:21 INFO : only11: Deleted 2024/10/30 04:42:22 INFO : only9: Deleted 2024/10/30 04:42:22 INFO : There was nothing to transfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (28.82s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:42:27 DEBUG : both0: md5 = 8d99ddf96a5ef8ce2410546c3580d239 OK 2024/10/30 04:42:27 DEBUG : only0: md5 = 3166703164f2592d93a0984b0afaa70f OK 2024/10/30 04:42:27 DEBUG : both1: md5 = 21b2a21a2d23606c5bcdf7416cce67f1 OK 2024/10/30 04:42:27 DEBUG : only1: md5 = 45000a6c71c6dcd754842461f04403e8 OK 2024/10/30 04:42:28 DEBUG : both2: md5 = 4d48516951f827d088c26df5680d4222 OK 2024/10/30 04:42:28 DEBUG : only2: md5 = 459fd92443646028f9da8a8d7594cebc OK 2024/10/30 04:42:28 DEBUG : both3: md5 = aa47f37bd3d88802e05098417f641923 OK 2024/10/30 04:42:28 DEBUG : only3: md5 = 3f4811046304e22a705c1931ee55fa91 OK 2024/10/30 04:42:28 DEBUG : both4: md5 = 083fbea7df92786a71c0973d701885af OK 2024/10/30 04:42:29 DEBUG : only4: md5 = 43bf6f2c9104b3cd660b112274c3868f OK 2024/10/30 04:42:29 DEBUG : both5: md5 = b8a3c1ea0adc87178c7e0019681b5da9 OK 2024/10/30 04:42:29 DEBUG : only5: md5 = 7a4de4b1c3e09f779d618602cb30613e OK 2024/10/30 04:42:29 DEBUG : both6: md5 = 3fe1acdceebcadcf5a2cfa1171aada08 OK 2024/10/30 04:42:29 DEBUG : only6: md5 = 8079a412e1be61f9c5146f93e05ea350 OK 2024/10/30 04:42:30 DEBUG : both7: md5 = 82f3f005b04e2843f378c02763c9ead3 OK 2024/10/30 04:42:30 DEBUG : only7: md5 = 31494213d6bb1a9dc746b9f86f6f6e11 OK 2024/10/30 04:42:30 DEBUG : both8: md5 = 44e2f19b65979bad5a1b4a3b87ebde5f OK 2024/10/30 04:42:30 DEBUG : only8: md5 = 6c72f8a1e5fdf0caaf20708611b339dc OK 2024/10/30 04:42:30 DEBUG : both9: md5 = 0145e6765261c7d8d29c658d54fb6209 OK 2024/10/30 04:42:30 DEBUG : only9: md5 = 806505a637cc63322ea5fe3ab1364adb OK 2024/10/30 04:42:31 DEBUG : both10: md5 = 0a2948d9ac50d4a1583937a1d9029cca OK 2024/10/30 04:42:31 DEBUG : only10: md5 = 648e26c977e4341c3e6dd5f4891a34f2 OK 2024/10/30 04:42:31 DEBUG : both11: md5 = f9bb26aedaa03c44da065a6ed880888e OK 2024/10/30 04:42:31 DEBUG : only11: md5 = 27b0b4b654a572aeca5e52362381563d OK 2024/10/30 04:42:31 DEBUG : both12: md5 = 8c099f05a29db77b2f193723c5e6b406 OK 2024/10/30 04:42:31 DEBUG : only12: md5 = 72dcf0f3753f911f4a36055ecf7d6da8 OK 2024/10/30 04:42:32 DEBUG : both13: md5 = dd4625d7ccd4616b6f617222fd978418 OK 2024/10/30 04:42:32 DEBUG : only13: md5 = 70d06251036ca2c99abdb73bf45b170e OK 2024/10/30 04:42:32 DEBUG : both14: md5 = 8a18e42648d862f0fac1db433eeec4ee OK 2024/10/30 04:42:33 DEBUG : only14: md5 = 38e0f7b9842c4c29a341d8ce69ec5276 OK 2024/10/30 04:42:33 DEBUG : both15: md5 = 9c16913f2f1a5d8c0ec2adf1dbf8f0ee OK 2024/10/30 04:42:33 DEBUG : only15: md5 = b6ae5a038d37b2df4517be982e79d260 OK 2024/10/30 04:42:34 DEBUG : both16: md5 = 407d358d1eb5b7cc2851616ed3579e59 OK 2024/10/30 04:42:34 DEBUG : only16: md5 = 0550b3a4438149e94232ca3b0a480c2e OK 2024/10/30 04:42:34 DEBUG : both17: md5 = 4d57e41e1761647691c1421d6575ed88 OK 2024/10/30 04:42:34 DEBUG : only17: md5 = ea7d3e887eddb567edf50ce71743556e OK 2024/10/30 04:42:34 DEBUG : both18: md5 = 2ae15c1628dcea504b1e060b8c31dcd3 OK 2024/10/30 04:42:35 DEBUG : only18: md5 = 9e7b47a37f06fb86a3e0f3d9813c231f OK 2024/10/30 04:42:35 DEBUG : both19: md5 = 45127151191f21896345965a66de15c0 OK 2024/10/30 04:42:35 DEBUG : only19: md5 = 3c496bd3d377a3ea02d8c968bf19876c OK 2024/10/30 04:42:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for checks to finish 2024/10/30 04:42:37 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both1: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both11: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both0: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both10: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both12: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both13: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both14: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both15: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both18: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both16: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both17: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both19: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:37 DEBUG : both3: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both2: Unchanged skipping 2024/10/30 04:42:37 DEBUG : both4: Unchanged skipping 2024/10/30 04:42:38 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:38 DEBUG : both5: Unchanged skipping 2024/10/30 04:42:38 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:38 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:38 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:38 DEBUG : both8: Unchanged skipping 2024/10/30 04:42:38 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : both7: Unchanged skipping 2024/10/30 04:42:38 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : both6: Unchanged skipping 2024/10/30 04:42:38 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2024/10/30 04:42:38 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 04:42:38 DEBUG : both9: Unchanged skipping 2024/10/30 04:42:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Waiting for transfers to finish 2024/10/30 04:42:38 DEBUG : only0: md5 = 409d97f778d2735b3d7c7358bc30dc17 OK 2024/10/30 04:42:38 INFO : only0: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only11: md5 = 3cb91ed52db852904ee9b7cfc4791348 OK 2024/10/30 04:42:38 INFO : only11: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only10: md5 = aa12b31a8c84dc11bd7588d78a4cf644 OK 2024/10/30 04:42:38 INFO : only10: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only13: md5 = 8ced349383f6d6a8375b45965b9e20d4 OK 2024/10/30 04:42:38 INFO : only13: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only1: md5 = d0b8373d3973ffb19e69fcce2b3897cd OK 2024/10/30 04:42:38 INFO : only1: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only14: md5 = 57eebf5ead01a59b36e9fd978f1156d1 OK 2024/10/30 04:42:38 INFO : only14: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only12: md5 = 3f04a98f746d916041e301e5d72828ce OK 2024/10/30 04:42:38 INFO : only12: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only19: md5 = b926a55be767677cce588d263cd03c9e OK 2024/10/30 04:42:38 INFO : only19: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only17: md5 = 62dd04fdaec7fb7d5f79c7668f4e117f OK 2024/10/30 04:42:38 INFO : only17: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only16: md5 = 24bed64fcc442adef30e10ff6f6aab38 OK 2024/10/30 04:42:38 INFO : only16: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only2: md5 = f4abf5a11d6103eba2aaa24d759cc726 OK 2024/10/30 04:42:38 INFO : only2: Copied (replaced existing) 2024/10/30 04:42:38 DEBUG : only3: md5 = bcb7d759e17adc6d5c0b5253dffdafd2 OK 2024/10/30 04:42:38 INFO : only3: Copied (replaced existing) 2024/10/30 04:42:39 DEBUG : only6: md5 = 84c346c266659263006ddcee589d9398 OK 2024/10/30 04:42:39 INFO : only6: Copied (replaced existing) 2024/10/30 04:42:39 DEBUG : only4: md5 = 72c2a5900b0bc2da0602414b10666f75 OK 2024/10/30 04:42:39 INFO : only4: Copied (replaced existing) 2024/10/30 04:42:39 DEBUG : only5: md5 = 693cdd39b9adc904dd15269aa3e7c7ae OK 2024/10/30 04:42:39 INFO : only5: Copied (replaced existing) 2024/10/30 04:42:39 DEBUG : only15: md5 = 0a01e333cb0e2ed6b9b259a9fda21bc9 OK 2024/10/30 04:42:39 INFO : only15: Copied (replaced existing) 2024/10/30 04:42:39 DEBUG : only8: md5 = ea844b3d7b3c64911bb4f12f250be2e3 OK 2024/10/30 04:42:39 INFO : only8: Copied (replaced existing) 2024/10/30 04:42:39 DEBUG : only9: md5 = 0ad127e5040387f6cd3efd7001a4a291 OK 2024/10/30 04:42:39 INFO : only9: Copied (replaced existing) 2024/10/30 04:42:39 DEBUG : only18: md5 = 8abaedc8d706a6501c32a4e3d9a8f926 OK 2024/10/30 04:42:39 INFO : only18: Copied (replaced existing) 2024/10/30 04:42:39 DEBUG : only7: md5 = a7add5d43010aee7c75517857e6e9288 OK 2024/10/30 04:42:39 INFO : only7: Copied (replaced existing) 2024/10/30 04:42:39 DEBUG : Waiting for deletions to finish run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (21.60s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:42:48 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/10/30 04:42:48 DEBUG : sub dir: Making directory 2024/10/30 04:42:48 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestNothingToTransferWithEmptyDirs (2.82s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" 2024/10/30 04:42:51 INFO : sub dir: Set directory modification time (using DirSetModTime) 2024/10/30 04:42:51 DEBUG : sub dir: Making directory 2024/10/30 04:42:51 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-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze'", Local "Local file system at /tmp/rclone401703151", Modify Window "1ns" --- PASS: TestNothingToTransferWithoutEmptyDirs (2.50s) PASS 2024/10/30 04:42:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wuzodal5kaze': Purge remote 2024/10/30 04:42:54 DEBUG : Waiting for deletions to finish "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 4m38.097723445s (try 1/5)