"./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 2/5) 2025/06/23 05:13:49 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju" 2025/06/23 05:13:49 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/23 05:13:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju.bin" 2025/06/23 05:13:50 DEBUG : Swift container crypt path rclone-test-yikemok6faju.bin: Auto set use_segments_container to true 2025/06/23 05:13:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju" 2025/06/23 05:13:55 DEBUG : Swift container crypt path rclone-test-yikemok6faju: Auto set use_segments_container to true 2025/06/23 05:14:01 DEBUG : Creating backend with remote "/tmp/rclone1826897293" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.06s) === 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-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:14:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:14:01 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2025/06/23 05:14:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:14:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish --- PASS: TestCopyWithDryRun (0.60s) === RUN TestCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:14:01 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/23 05:14:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:14:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:14:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:14:06 DEBUG : sub dir/hello world: md5 = adc020d143f7164a4d5da93474c7c484 OK 2025/06/23 05:14:06 INFO : sub dir/hello world: Copied (new) 2025/06/23 05:14:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (15.76s) === RUN TestCopyMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:98: Skipping as metadata not supported --- SKIP: TestCopyMetadata (0.10s) === RUN TestCopyMetadataNoEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:98: Skipping as metadata not supported --- SKIP: TestCopyMetadataNoEmptyDirs (0.10s) === RUN TestCopyMissingDirectory run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:14:17 DEBUG : Creating backend with remote "/non-existing" 2025/06/23 05:14:17 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2025/06/23 05:14:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:14:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.15s) === RUN TestCopyNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:14:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:14:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:14:22 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:14:27 DEBUG : sub dir/hello world: md5 = dd62433b9e594b69da16661c77d3afb3 OK 2025/06/23 05:14:27 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoTraverse (20.81s) === RUN TestCopyCheckFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:14:38 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Running all checks before starting transfers 2025/06/23 05:14:38 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:14:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:14:38 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Checks finished, now starting transfers 2025/06/23 05:14:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:14:43 DEBUG : sub dir/hello world: md5 = cc0f356f793118c9918dc98dfebf9744 OK 2025/06/23 05:14:43 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyCheckFirst (10.81s) === RUN TestSyncNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:14:49 ERROR : Ignoring --no-traverse with sync 2025/06/23 05:14:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:14:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:14:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:14:54 DEBUG : sub dir/hello world: md5 = 388d99420febc75cc9102050cbf0f013 OK 2025/06/23 05:14:54 INFO : sub dir/hello world: Copied (new) 2025/06/23 05:14:54 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoTraverse (20.74s) === RUN TestCopyWithDepth run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:15:10 DEBUG : hello world2: Need to transfer - File not found at Destination 2025/06/23 05:15:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:15:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:15:10 DEBUG : hello world2: md5 = 89a98b02d18a3aa5046030ba941885b7 OK 2025/06/23 05:15:10 INFO : hello world2: Copied (new) --- PASS: TestCopyWithDepth (1.22s) === RUN TestCopyWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:15:11 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:15:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:15:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:15:12 DEBUG : potato2: md5 = fa8ec11b5c6af7bd0f4dd1d4cc12a6cc OK 2025/06/23 05:15:12 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFrom (1.64s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:15:18 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:15:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:15:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:15:18 DEBUG : potato2: md5 = 770a32a1f539b077b950ffb94ccdea0b OK 2025/06/23 05:15:18 INFO : potato2: Copied (new) --- PASS: TestCopyWithFilesFromAndNoTraverse (5.98s) === RUN TestCopyEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:15:18 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/06/23 05:15:18 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/23 05:15:18 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/06/23 05:15:18 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/23 05:15:19 INFO : sub dir2: Making directory 2025/06/23 05:15:19 INFO : sub dir: Making directory 2025/06/23 05:15:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:15:19 INFO : sub dir2/sub sub dir2: Making directory 2025/06/23 05:15:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:15:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:15:24 DEBUG : sub dir/hello world: md5 = 070858cda11bd210b412d19a6ff2fd1c OK 2025/06/23 05:15:24 INFO : sub dir/hello world: Copied (new) fstest.go:247: Filtering empty directory "sub dir2" fstest.go:247: Filtering empty directory "sub dir2/sub sub dir2" 2025/06/23 05:15:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (10.84s) === RUN TestCopyNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:15:29 INFO : sub dir2: Making directory 2025/06/23 05:15:29 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/06/23 05:15:29 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/23 05:15:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:15:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:15:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:15:35 DEBUG : sub dir/hello world: md5 = ea4c800111507dc6526105126339df15 OK 2025/06/23 05:15:35 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyNoEmptyDirectories (11.17s) === RUN TestMoveEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:15:41 DEBUG : sub dir2: Making directory with metadata 2025/06/23 05:15:41 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/23 05:15:41 INFO : sub dir2: Making directory 2025/06/23 05:15:41 INFO : sub dir: Making directory 2025/06/23 05:15:41 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:15:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:15:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:15:46 DEBUG : sub dir/hello world: md5 = 51f184e1a878c3477aee78678b164f2f OK 2025/06/23 05:15:46 INFO : sub dir/hello world: Copied (new) 2025/06/23 05:15:46 INFO : sub dir/hello world: Deleted fstest.go:247: Filtering empty directory "sub dir2" 2025/06/23 05:15:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata 2025/06/23 05:15:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestMoveEmptyDirectories (15.90s) === RUN TestSyncNoUpdateDirModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:409: Skipping test as backend does not support DirSetModTime --- SKIP: TestSyncNoUpdateDirModtime (0.26s) === RUN TestMoveNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:15:57 INFO : sub dir2: Making directory 2025/06/23 05:15:57 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:15:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:15:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:16:02 DEBUG : sub dir/hello world: md5 = 8a043ddb04bfa68ebf5994455d12f2cd OK 2025/06/23 05:16:02 INFO : sub dir/hello world: Copied (new) 2025/06/23 05:16:02 INFO : sub dir/hello world: Deleted --- PASS: TestMoveNoEmptyDirectories (15.89s) === RUN TestSyncEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:16:13 DEBUG : sub dir2: Making directory with metadata 2025/06/23 05:16:13 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/23 05:16:13 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/23 05:16:13 INFO : sub dir2: Making directory 2025/06/23 05:16:13 INFO : sub dir: Making directory 2025/06/23 05:16:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:16:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:16:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:16:18 DEBUG : sub dir/hello world: md5 = 6e14dfe8eab2cd8222d6cea7dc3f450a OK 2025/06/23 05:16:18 INFO : sub dir/hello world: Copied (new) 2025/06/23 05:16:18 DEBUG : Waiting for deletions to finish fstest.go:247: Filtering empty directory "sub dir2" 2025/06/23 05:16:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestSyncEmptyDirectories (10.87s) === RUN TestSyncSetDelayedModTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:508: Backend doesn't have DirModTimeUpdatesOnWrite set --- SKIP: TestSyncSetDelayedModTimes (0.20s) === RUN TestSyncNoEmptyDirectories run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:16:24 INFO : sub dir2: Making directory 2025/06/23 05:16:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:16:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:16:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:16:29 DEBUG : sub dir/hello world: md5 = 6f919b71dabd19c9c20748984cb4577d OK 2025/06/23 05:16:29 INFO : sub dir/hello world: Copied (new) 2025/06/23 05:16:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncNoEmptyDirectories (10.75s) === RUN TestServerSideCopy run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:16:40 DEBUG : sub dir/hello world: md5 = 6f4e02dd9a3560e8f6574fce0ab950af OK 2025/06/23 05:16:40 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-zonosit4quwo" 2025/06/23 05:16:40 DEBUG : Config file has changed externally - reloading 2025/06/23 05:16:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zonosit4quwo.bin" 2025/06/23 05:16:40 DEBUG : Swift container crypt path rclone-test-zonosit4quwo.bin: Auto set use_segments_container to true 2025/06/23 05:16:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-zonosit4quwo" 2025/06/23 05:16:46 DEBUG : Swift container crypt path rclone-test-zonosit4quwo: Auto set use_segments_container to true sync_test.go:591: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju' -> Encrypted drive 'TestCryptSwift:rclone-test-zonosit4quwo' 2025/06/23 05:16:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:16:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zonosit4quwo': Waiting for checks to finish 2025/06/23 05:16:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zonosit4quwo': Waiting for transfers to finish 2025/06/23 05:17:07 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/23 05:17:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-zonosit4quwo': Purge remote 2025/06/23 05:17:07 DEBUG : Waiting for deletions to finish 2025/06/23 05:17:12 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopy (48.16s) === RUN TestCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:17:28 DEBUG : sub dir/hello world: md5 = 37cd74c4834a649a0ac43742664ee890 OK 2025/06/23 05:17:33 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/23 05:17:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:17:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:17:43 DEBUG : sub dir/hello world: md5 = 61ae51f63d0aaa176c4a553bcbec955a OK 2025/06/23 05:17:43 INFO : sub dir/hello world: Copied (replaced existing) --- PASS: TestCopyOverSelf (29.25s) === RUN TestServerSideCopyOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:17:57 DEBUG : sub dir/hello world: md5 = 541540f173c9d64e63b2fc6204b93e78 OK 2025/06/23 05:18:02 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tidulib0goqa" 2025/06/23 05:18:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tidulib0goqa.bin" 2025/06/23 05:18:03 DEBUG : Swift container crypt path rclone-test-tidulib0goqa.bin: Auto set use_segments_container to true 2025/06/23 05:18:08 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tidulib0goqa" 2025/06/23 05:18:08 DEBUG : Swift container crypt path rclone-test-tidulib0goqa: Auto set use_segments_container to true sync_test.go:627: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju' -> Encrypted drive 'TestCryptSwift:rclone-test-tidulib0goqa' 2025/06/23 05:18:19 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:18:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tidulib0goqa': Waiting for checks to finish 2025/06/23 05:18:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tidulib0goqa': Waiting for transfers to finish 2025/06/23 05:18:25 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/23 05:18:30 DEBUG : sub dir/hello world: md5 = 5a7c7b571c901ffd3901247125c89f23 OK 2025/06/23 05:18:30 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/23 05:18:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tidulib0goqa': Waiting for checks to finish 2025/06/23 05:18:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tidulib0goqa': Waiting for transfers to finish 2025/06/23 05:18:41 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/23 05:18:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tidulib0goqa': Purge remote 2025/06/23 05:18:41 DEBUG : Waiting for deletions to finish 2025/06/23 05:18:41 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideCopyOverSelf (60.25s) === RUN TestMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:18:57 DEBUG : sub dir/hello world: md5 = 88c740a37c3886550759999d3dc7ab28 OK 2025/06/23 05:18:58 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/23 05:18:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:18:58 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:19:03 DEBUG : sub dir/hello world: md5 = 865e449e0a87d7280422c56b26783767 OK 2025/06/23 05:19:03 INFO : sub dir/hello world: Copied (replaced existing) 2025/06/23 05:19:03 INFO : sub dir/hello world: Deleted --- PASS: TestMoveOverSelf (26.35s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:19:23 DEBUG : sub dir/hello world: md5 = 345a361b04c8fed252ad482235186029 OK 2025/06/23 05:19:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wamoxek6xiwi" 2025/06/23 05:19:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wamoxek6xiwi.bin" 2025/06/23 05:19:24 DEBUG : Swift container crypt path rclone-test-wamoxek6xiwi.bin: Auto set use_segments_container to true 2025/06/23 05:19:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wamoxek6xiwi" 2025/06/23 05:19:30 DEBUG : Swift container crypt path rclone-test-wamoxek6xiwi: Auto set use_segments_container to true sync_test.go:672: Server side copy (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju' -> Encrypted drive 'TestCryptSwift:rclone-test-wamoxek6xiwi' 2025/06/23 05:19:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:19:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wamoxek6xiwi': Waiting for checks to finish 2025/06/23 05:19:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wamoxek6xiwi': Waiting for transfers to finish 2025/06/23 05:19:49 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/23 05:19:55 DEBUG : sub dir/hello world: md5 = 7260177e5640e07249026309c6929428 OK 2025/06/23 05:20:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wamoxek6xiwi': Waiting for checks to finish 2025/06/23 05:20:00 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/06/23 05:20:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wamoxek6xiwi': Waiting for transfers to finish 2025/06/23 05:20:05 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/23 05:20:11 INFO : sub dir/hello world: Deleted 2025/06/23 05:20:16 DEBUG : sub dir/hello world: md5 = baf795b3912ce7f8a21823e01db56816 OK 2025/06/23 05:20:21 DEBUG : testing file moves 2025/06/23 05:20:21 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2025/06/23 05:20:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wamoxek6xiwi': Waiting for checks to finish 2025/06/23 05:20:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wamoxek6xiwi': Waiting for transfers to finish 2025/06/23 05:20:32 INFO : sub dir/hello world: Copied (server-side copy) 2025/06/23 05:20:37 INFO : sub dir/hello world: Deleted 2025/06/23 05:20:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wamoxek6xiwi': Purge remote 2025/06/23 05:20:37 DEBUG : Waiting for deletions to finish 2025/06/23 05:20:37 INFO : sub dir/hello world.bin: Deleted --- PASS: TestServerSideMoveOverSelf (79.40s) === RUN TestCopyAfterDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:20:43 DEBUG : sub dir/hello world: md5 = 4ee0276696f95167988552eb30266bac OK 2025/06/23 05:20:43 ERROR : error listing: directory not found 2025/06/23 05:20:43 INFO : Local file system at /tmp/rclone1826897293: Making directory 2025/06/23 05:20:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:20:43 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish --- PASS: TestCopyAfterDelete (21.09s) === RUN TestCopyRedownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:21:04 DEBUG : sub dir/hello world: md5 = 93de579bc0669c67e6cba77c41dac261 OK 2025/06/23 05:21:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:21:09 DEBUG : Local file system at /tmp/rclone1826897293: Waiting for checks to finish 2025/06/23 05:21:09 DEBUG : Local file system at /tmp/rclone1826897293: Waiting for transfers to finish 2025/06/23 05:21:09 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world 2025/06/23 05:21:09 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (24.02s) === RUN TestSyncBasedOnCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:21:23 DEBUG : check sum: Need to transfer - File not found at Destination 2025/06/23 05:21:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:21:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:21:23 DEBUG : check sum: md5 = 021406ff910d66b13b02a1c0131578cb OK 2025/06/23 05:21:23 INFO : check sum: Copied (new) 2025/06/23 05:21:23 DEBUG : Waiting for deletions to finish 2025/06/23 05:21:24 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2025/06/23 05:21:24 DEBUG : check sum: Size of src and dst objects identical 2025/06/23 05:21:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:21:24 DEBUG : check sum: Unchanged skipping 2025/06/23 05:21:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:21:24 DEBUG : Waiting for deletions to finish 2025/06/23 05:21:24 INFO : There was nothing to transfer --- PASS: TestSyncBasedOnCheckSum (1.32s) === RUN TestSyncSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:21:24 DEBUG : sizeonly: Need to transfer - File not found at Destination 2025/06/23 05:21:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:21:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:21:25 DEBUG : sizeonly: md5 = d9b665c5b8136930c58293298c1bef6a OK 2025/06/23 05:21:25 INFO : sizeonly: Copied (new) 2025/06/23 05:21:25 DEBUG : Waiting for deletions to finish 2025/06/23 05:21:25 DEBUG : sizeonly: Sizes identical 2025/06/23 05:21:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:21:25 DEBUG : sizeonly: Unchanged skipping 2025/06/23 05:21:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:21:25 DEBUG : Waiting for deletions to finish 2025/06/23 05:21:25 INFO : There was nothing to transfer --- PASS: TestSyncSizeOnly (1.33s) === RUN TestSyncIgnoreSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:21:26 DEBUG : ignore-size: Need to transfer - File not found at Destination 2025/06/23 05:21:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:21:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:21:31 DEBUG : ignore-size: md5 = 58c2f761d886f999c02b0cae03ca2cfa OK 2025/06/23 05:21:31 INFO : ignore-size: Copied (new) 2025/06/23 05:21:31 DEBUG : Waiting for deletions to finish 2025/06/23 05:21:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:21:36 DEBUG : ignore-size: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:21:36 DEBUG : ignore-size: Unchanged skipping 2025/06/23 05:21:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:21:36 DEBUG : Waiting for deletions to finish 2025/06/23 05:21:36 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreSize (26.27s) === RUN TestSyncIgnoreTimes run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:21:57 DEBUG : existing: md5 = 33c3518de0d81e9c4d568ea2e3d387e3 OK 2025/06/23 05:21:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:22:02 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:22:02 DEBUG : existing: Unchanged skipping 2025/06/23 05:22:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:22:02 DEBUG : Waiting for deletions to finish 2025/06/23 05:22:02 INFO : There was nothing to transfer 2025/06/23 05:22:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:22:03 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/06/23 05:22:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:22:08 DEBUG : existing: md5 = 4156e1885b4fd2deac4d01cfda45d8c7 OK 2025/06/23 05:22:08 INFO : existing: Copied (replaced existing) 2025/06/23 05:22:08 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (26.67s) === RUN TestSyncIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:22:19 DEBUG : existing: Need to transfer - File not found at Destination 2025/06/23 05:22:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:22:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:22:24 DEBUG : existing: md5 = b4b75800c788eb0b60fb3a2b8d66d9d6 OK 2025/06/23 05:22:24 INFO : existing: Copied (new) 2025/06/23 05:22:24 DEBUG : Waiting for deletions to finish 2025/06/23 05:22:24 DEBUG : existing: Destination exists, skipping 2025/06/23 05:22:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:22:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:22:24 DEBUG : Waiting for deletions to finish 2025/06/23 05:22:24 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreExisting (21.30s) === RUN TestSyncIgnoreErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:22:40 DEBUG : b/potato: md5 = 77340d5497fc65904f5e49bb5064a520 OK 2025/06/23 05:22:41 DEBUG : c/non empty space: md5 = d86a1df5def74c108f3694f5d0c87d62 OK 2025/06/23 05:22:41 INFO : d: Making directory fstest.go:247: Filtering empty directory "d" 2025/06/23 05:22:42 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/06/23 05:22:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:22:42 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:22:42 DEBUG : c/non empty space: Unchanged skipping 2025/06/23 05:22:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:22:47 DEBUG : a/potato2: md5 = fddea17f0aeedaa6f046ef9e1df6fcaf OK 2025/06/23 05:22:47 INFO : a/potato2: Copied (new) 2025/06/23 05:22:47 DEBUG : Waiting for deletions to finish 2025/06/23 05:22:48 INFO : b/potato: Deleted --- PASS: TestSyncIgnoreErrors (19.17s) === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:23:00 DEBUG : empty space: md5 = 53f08c6e1312963a10bc28ab9d998bc6 OK 2025/06/23 05:23:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:23:00 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/06/23 05:23:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:23:00 NOTICE: empty space: Skipped copy as --dry-run is set (size 1) 2025/06/23 05:23:00 DEBUG : Waiting for deletions to finish 2025/06/23 05:23:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:23:01 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/06/23 05:23:01 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:23:01 DEBUG : empty space: md5 = e89dda0fd57fdd094133def6b4b0eb17 OK 2025/06/23 05:23:01 INFO : empty space: Copied (replaced existing) 2025/06/23 05:23:01 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingModtimeOnly (3.00s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:1017: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.33s) === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:23:03 DEBUG : foo: md5 = e02cdfdbd952646b57fb6fae2879380b OK 2025/06/23 05:23:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:23:03 DEBUG : foo: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC 2025/06/23 05:23:03 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:23:03 DEBUG : foo: md5 = 58d1dfe062a9cd128a7486d6b3e7ce86 OK 2025/06/23 05:23:03 INFO : foo: Copied (replaced existing) 2025/06/23 05:23:03 DEBUG : Waiting for deletions to finish --- PASS: TestSyncDoesntUpdateModtime (1.78s) === RUN TestSyncAfterAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:23:04 DEBUG : empty space: md5 = 22dd74c04e4f859d0e5ce7a1a33d7ba6 OK 2025/06/23 05:23:04 DEBUG : potato: Need to transfer - File not found at Destination 2025/06/23 05:23:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:23:05 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:23:05 DEBUG : empty space: Unchanged skipping 2025/06/23 05:23:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:23:10 DEBUG : potato: md5 = 80399f6dd5c73d693d7e41f4dedb899a OK 2025/06/23 05:23:10 INFO : potato: Copied (new) 2025/06/23 05:23:10 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (21.29s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:23:31 DEBUG : potato: md5 = f306976cf09e7fd2da307cbc7e5f2377 OK 2025/06/23 05:23:36 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2025/06/23 05:23:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:23:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:23:41 DEBUG : potato: md5 = a237ecc8dd0a0e4068e411082f3d727c OK 2025/06/23 05:23:41 INFO : potato: Copied (replaced existing) 2025/06/23 05:23:41 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (26.22s) === RUN TestSyncAfterChangingContentsOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:23:57 DEBUG : potato: md5 = bcf7a2e8a7286ddc5f9effd5b7cab18f OK 2025/06/23 05:23:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:23:57 DEBUG : potato: Modification times differ by 119h59m59.876543211s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2011-12-30 12:59:59 +0000 UTC 2025/06/23 05:23:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:24:02 DEBUG : potato: md5 = a8d0e654ddf2372bf02fdd6f88181d93 OK 2025/06/23 05:24:02 INFO : potato: Copied (replaced existing) 2025/06/23 05:24:02 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (21.33s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:24:18 DEBUG : potato: md5 = f14db458d57e65ab6f5a36228a88af55 OK 2025/06/23 05:24:18 DEBUG : empty space: md5 = a2c2908d607694dbe5af7462a57100a5 OK 2025/06/23 05:24:18 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:24:18 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2025/06/23 05:24:19 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:24:24 DEBUG : empty space: Unchanged skipping 2025/06/23 05:24:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:24:24 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:24:24 DEBUG : Waiting for deletions to finish 2025/06/23 05:24:24 NOTICE: potato: Skipped delete as --dry-run is set (size 21) --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (16.32s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:24:34 DEBUG : potato: md5 = ba99e8d12adb4ec1ca18c519d9ae0d9e OK 2025/06/23 05:24:35 DEBUG : empty space: md5 = 596ad85f5659950165260222b7717a09 OK 2025/06/23 05:24:35 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:24:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:24:35 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:24:35 DEBUG : empty space: Unchanged skipping 2025/06/23 05:24:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:24:35 DEBUG : potato2: md5 = 078d77d6135f5e137e226874e85ef41b OK 2025/06/23 05:24:35 INFO : potato2: Copied (new) 2025/06/23 05:24:35 DEBUG : Waiting for deletions to finish 2025/06/23 05:24:40 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (12.05s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:24:41 DEBUG : b/potato: md5 = 5bd21d84d4ce3aaab4f6e7382042fb6b OK 2025/06/23 05:24:42 DEBUG : c/non empty space: md5 = e7d4d9eb8acd5048e6bf5e20a27d2e17 OK 2025/06/23 05:24:42 INFO : d: Making directory 2025/06/23 05:24:42 INFO : d/e: Making directory fstest.go:247: Filtering empty directory "d" fstest.go:247: Filtering empty directory "d/e" 2025/06/23 05:24:42 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/06/23 05:24:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:24:42 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:24:42 DEBUG : c/non empty space: Unchanged skipping 2025/06/23 05:24:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:24:47 DEBUG : a/potato2: md5 = 3ddde8f613a3b6c5f428193726637307 OK 2025/06/23 05:24:47 INFO : a/potato2: Copied (new) 2025/06/23 05:24:47 DEBUG : Waiting for deletions to finish 2025/06/23 05:24:48 INFO : b/potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (22.32s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:25:04 DEBUG : b/potato: md5 = d18730fab92b1ec35f11ac8b14e3313b OK 2025/06/23 05:25:04 DEBUG : c/non empty space: md5 = f5107a0558f7d08448b558941b724e38 OK 2025/06/23 05:25:04 INFO : d: Making directory fstest.go:247: Filtering empty directory "d" 2025/06/23 05:25:04 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/06/23 05:25:04 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:25:04 DEBUG : c/non empty space: Unchanged skipping 2025/06/23 05:25:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:25:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:25:10 DEBUG : a/potato2: md5 = 176c1c00544e57468f83f8f35ac22d9b OK 2025/06/23 05:25:10 INFO : a/potato2: Copied (new) 2025/06/23 05:25:10 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': not deleting files as there were IO errors 2025/06/23 05:25:10 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': not deleting directories as there were IO errors fstest.go:247: Filtering empty directory "d" --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (12.27s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:25:22 DEBUG : potato: md5 = d709086280a4803137330d81aaeb6971 OK 2025/06/23 05:25:22 DEBUG : empty space: md5 = 1e2cbb4f59a35bf2115a78237056e064 OK 2025/06/23 05:25:22 DEBUG : Waiting for deletions to finish 2025/06/23 05:25:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:25:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:25:23 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:25:23 DEBUG : empty space: Unchanged skipping 2025/06/23 05:25:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:25:23 DEBUG : potato2: md5 = 7c69f3e396aad929568cfb129f06fb97 OK 2025/06/23 05:25:23 INFO : potato2: Copied (new) 2025/06/23 05:25:28 INFO : potato: Deleted --- PASS: TestSyncDeleteDuring (12.96s) === RUN TestSyncDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:25:35 DEBUG : potato: md5 = 0e1bfb52535a5247debe3405d1aba50c OK 2025/06/23 05:25:35 DEBUG : empty space: md5 = 251e2c6f6e9c6a8b8f798256790b7de1 OK 2025/06/23 05:25:36 DEBUG : Waiting for deletions to finish 2025/06/23 05:25:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:25:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:25:41 INFO : potato: Deleted 2025/06/23 05:25:41 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:25:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:25:41 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:25:41 DEBUG : empty space: Unchanged skipping 2025/06/23 05:25:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:25:41 DEBUG : potato2: md5 = f6cca293f88da633effc4dce27a976fc OK 2025/06/23 05:25:41 INFO : potato2: Copied (new) --- PASS: TestSyncDeleteBefore (13.34s) === RUN TestCopyDeleteBefore run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:25:47 DEBUG : potato: md5 = ad98067dff43513a0a855801daf81025 OK 2025/06/23 05:25:48 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:25:48 DEBUG : potato2: md5 = beb510557a2ed01b67af654d888f4fb0 OK 2025/06/23 05:25:48 INFO : potato2: Copied (new) 2025/06/23 05:25:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:25:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish --- PASS: TestCopyDeleteBefore (16.63s) === RUN TestSyncWithExclude run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:25:59 DEBUG : potato2: md5 = f5ee4095dca5089eabc9284ff621afb5 OK 2025/06/23 05:25:59 DEBUG : empty space: md5 = f9cb093a463cc9d12a4643cc10686d06 OK 2025/06/23 05:26:00 DEBUG : enormous: Excluded (Size Filter) 2025/06/23 05:26:00 DEBUG : enormous: Excluded 2025/06/23 05:26:00 DEBUG : potato2: Excluded (Size Filter) 2025/06/23 05:26:00 DEBUG : potato2: Excluded 2025/06/23 05:26:00 DEBUG : potato2: Excluded (Size Filter) 2025/06/23 05:26:00 DEBUG : potato2: Excluded 2025/06/23 05:26:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:26:00 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:26:00 DEBUG : empty space: Unchanged skipping 2025/06/23 05:26:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:26:00 DEBUG : Waiting for deletions to finish 2025/06/23 05:26:00 INFO : There was nothing to transfer 2025/06/23 05:26:00 DEBUG : enormous: Excluded (Size Filter) 2025/06/23 05:26:00 DEBUG : enormous: Excluded 2025/06/23 05:26:00 DEBUG : potato2: Excluded (Size Filter) 2025/06/23 05:26:00 DEBUG : potato2: Excluded 2025/06/23 05:26:00 DEBUG : potato2: Excluded (Size Filter) 2025/06/23 05:26:00 DEBUG : potato2: Excluded 2025/06/23 05:26:00 DEBUG : Local file system at /tmp/rclone1826897293: Waiting for checks to finish 2025/06/23 05:26:00 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:26:00 DEBUG : empty space: Unchanged skipping 2025/06/23 05:26:00 DEBUG : Local file system at /tmp/rclone1826897293: Waiting for transfers to finish 2025/06/23 05:26:00 DEBUG : Waiting for deletions to finish 2025/06/23 05:26:00 INFO : There was nothing to transfer --- PASS: TestSyncWithExclude (1.72s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:26:01 DEBUG : potato2: md5 = a043a53375d85fb853eddbadc201cb1a OK 2025/06/23 05:26:01 DEBUG : empty space: md5 = 73c337b9fbffd14362505cad5fba634a OK 2025/06/23 05:26:06 DEBUG : enormous: md5 = 6c8aa909b4df2bb560fde3f9ffbf156b OK 2025/06/23 05:26:06 DEBUG : enormous: Excluded (Size Filter) 2025/06/23 05:26:06 DEBUG : enormous: Excluded 2025/06/23 05:26:06 DEBUG : potato2: Excluded (Size Filter) 2025/06/23 05:26:06 DEBUG : potato2: Excluded 2025/06/23 05:26:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:26:07 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:26:07 DEBUG : empty space: Unchanged skipping 2025/06/23 05:26:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:26:07 DEBUG : Waiting for deletions to finish 2025/06/23 05:26:07 INFO : potato2: Deleted 2025/06/23 05:26:12 INFO : enormous: Deleted 2025/06/23 05:26:12 INFO : There was nothing to transfer 2025/06/23 05:26:12 DEBUG : Local file system at /tmp/rclone1826897293: Waiting for checks to finish 2025/06/23 05:26:12 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:26:12 DEBUG : empty space: Unchanged skipping 2025/06/23 05:26:12 DEBUG : Local file system at /tmp/rclone1826897293: Waiting for transfers to finish 2025/06/23 05:26:12 DEBUG : Waiting for deletions to finish 2025/06/23 05:26:12 INFO : enormous: Deleted 2025/06/23 05:26:12 INFO : potato2: Deleted 2025/06/23 05:26:12 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (12.01s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:26:18 DEBUG : one: md5 = 5ea42bc3ac36f206008044da1469c582 OK 2025/06/23 05:26:18 DEBUG : two: md5 = 01836a137bbd6153fc980555227199b2 OK 2025/06/23 05:26:19 DEBUG : three: md5 = 59e2c3b92ade1535cccd58d89eb60352 OK 2025/06/23 05:26:24 DEBUG : four: md5 = d3bab6c44fa4463c056a492948dfbd34 OK 2025/06/23 05:26:35 DEBUG : five: Need to transfer - File not found at Destination 2025/06/23 05:26:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:26:35 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/06/23 05:26:35 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/06/23 05:26:35 DEBUG : one: Destination is newer than source, skipping 2025/06/23 05:26:35 DEBUG : three: Sizes identical 2025/06/23 05:26:35 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/06/23 05:26:35 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:26:35 DEBUG : two: md5 = 48760ac16bf9e902620ee4b10c116794 OK 2025/06/23 05:26:35 INFO : two: Copied (replaced existing) 2025/06/23 05:26:35 DEBUG : five: md5 = 18a8ea7c5f0448b282f76387fc7bf2c4 OK 2025/06/23 05:26:35 INFO : five: Copied (new) 2025/06/23 05:26:40 DEBUG : four: md5 = 4c768aabac98647870757935cb48addb OK 2025/06/23 05:26:40 INFO : four: Copied (replaced existing) 2025/06/23 05:26:40 DEBUG : Waiting for deletions to finish sync_test.go:1450: Skip test with --checksum as no hashes supported --- PASS: TestSyncWithUpdateOlder (58.84s) === RUN TestSyncWithMaxDuration === RUN TestSyncWithMaxDuration/Hard sync_test.go:1467: Skipping test on non local remote === RUN TestSyncWithMaxDuration/Soft sync_test.go:1467: Skipping test on non local remote --- PASS: TestSyncWithMaxDuration (0.00s) --- SKIP: TestSyncWithMaxDuration/Hard (0.00s) --- SKIP: TestSyncWithMaxDuration/Soft (0.00s) === RUN TestSyncWithTrackRenames run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:1539: Can track renames: false 2025/06/23 05:27:11 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Ignoring --track-renames as the source and destination do not have a common hash 2025/06/23 05:27:12 DEBUG : potato: Need to transfer - File not found at Destination 2025/06/23 05:27:12 DEBUG : yam: Need to transfer - File not found at Destination 2025/06/23 05:27:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:27:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:27:17 DEBUG : potato: md5 = c82fe57266f31871bfec3476fae542cf OK 2025/06/23 05:27:17 INFO : potato: Copied (new) 2025/06/23 05:27:17 DEBUG : yam: md5 = cb80aa5fdb8c5f7fc16a91a7dbe330cf OK 2025/06/23 05:27:17 INFO : yam: Copied (new) 2025/06/23 05:27:17 DEBUG : Waiting for deletions to finish 2025/06/23 05:27:17 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Ignoring --track-renames as the source and destination do not have a common hash 2025/06/23 05:27:17 DEBUG : yaml: Need to transfer - File not found at Destination 2025/06/23 05:27:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:27:17 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:27:17 DEBUG : potato: Unchanged skipping 2025/06/23 05:27:17 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:27:22 DEBUG : yaml: md5 = beecac5aacb121b925dfdfb99acbe239 OK 2025/06/23 05:27:22 INFO : yaml: Copied (new) 2025/06/23 05:27:22 DEBUG : Waiting for deletions to finish 2025/06/23 05:27:27 INFO : yam: Deleted --- PASS: TestSyncWithTrackRenames (27.02s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:1611: Can track renames: true 2025/06/23 05:27:38 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Making map for --track-renames 2025/06/23 05:27:38 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Finished making map for --track-renames 2025/06/23 05:27:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:27:38 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/23 05:27:38 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/06/23 05:27:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for renames to finish 2025/06/23 05:27:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:27:44 DEBUG : yam: md5 = a9c36d4c3e9a442979d33d62058d925f OK 2025/06/23 05:27:44 INFO : yam: Copied (new) 2025/06/23 05:27:44 DEBUG : potato: md5 = f3ca04a737d378ebbdb304354aa6b9c6 OK 2025/06/23 05:27:44 INFO : potato: Copied (new) 2025/06/23 05:27:44 DEBUG : Waiting for deletions to finish 2025/06/23 05:27:49 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Making map for --track-renames 2025/06/23 05:27:49 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Finished making map for --track-renames 2025/06/23 05:27:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:27:49 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:27:49 DEBUG : potato: Unchanged skipping 2025/06/23 05:27:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for renames to finish 2025/06/23 05:28:10 INFO : yam: Copied (server-side copy) to: yaml 2025/06/23 05:28:15 INFO : yam: Deleted 2025/06/23 05:28:15 INFO : yaml: Renamed from "yam" 2025/06/23 05:28:15 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:28:15 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyModtime (47.33s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:1650: Can track renames: true 2025/06/23 05:28:26 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Making map for --track-renames 2025/06/23 05:28:26 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Finished making map for --track-renames 2025/06/23 05:28:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:28:26 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/23 05:28:26 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/06/23 05:28:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for renames to finish 2025/06/23 05:28:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:28:27 DEBUG : sub/yam: md5 = e5eac561951df21817d316e23617516a OK 2025/06/23 05:28:27 INFO : sub/yam: Copied (new) 2025/06/23 05:28:31 DEBUG : potato: md5 = 59d4d078a3ac533541bd44f8074e446e OK 2025/06/23 05:28:31 INFO : potato: Copied (new) 2025/06/23 05:28:31 DEBUG : Waiting for deletions to finish 2025/06/23 05:28:32 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:28:32 DEBUG : potato: Unchanged skipping 2025/06/23 05:28:32 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Making map for --track-renames 2025/06/23 05:28:32 INFO : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Finished making map for --track-renames 2025/06/23 05:28:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:28:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for renames to finish 2025/06/23 05:28:48 INFO : sub/yam: Copied (server-side copy) to: yam 2025/06/23 05:28:48 INFO : sub/yam: Deleted 2025/06/23 05:28:48 INFO : yam: Renamed from "sub/yam" 2025/06/23 05:28:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:28:48 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithTrackRenamesStrategyLeaf (42.82s) === RUN TestServerSideMoveLocal run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:29:09 DEBUG : Creating backend with remote "/tmp/rclone1826897293/dir1" 2025/06/23 05:29:09 DEBUG : Config file has changed externally - reloading 2025/06/23 05:29:09 DEBUG : Creating backend with remote "/tmp/rclone1826897293/dir2" 2025/06/23 05:29:09 DEBUG : Local file system at /tmp/rclone1826897293/dir2: Using server-side directory move 2025/06/23 05:29:09 INFO : Local file system at /tmp/rclone1826897293/dir2: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/06/23 05:29:09 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/06/23 05:29:09 DEBUG : Local file system at /tmp/rclone1826897293/dir2: Waiting for checks to finish 2025/06/23 05:29:09 DEBUG : Local file system at /tmp/rclone1826897293/dir2: Waiting for transfers to finish 2025/06/23 05:29:09 INFO : file1.txt: Moved (server-side) --- PASS: TestServerSideMoveLocal (0.11s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:29:09 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:29:09 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/06/23 05:29:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:29:09 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:29:14 DEBUG : sub dir/hello world: md5 = ab9cf4dc30e51edc0801a28c9d77b3d2 OK 2025/06/23 05:29:14 INFO : sub dir/hello world: Copied (new) 2025/06/23 05:29:14 INFO : sub dir/hello world: Deleted 2025/06/23 05:29:15 DEBUG : nested/sub dir/file: md5 = 9745c667dcf459d5aa954c0310ce4fd1 OK 2025/06/23 05:29:15 INFO : nested/sub dir/file: Copied (new) 2025/06/23 05:29:15 INFO : nested/sub dir/file: Deleted 2025/06/23 05:29:15 INFO : sub dir: Removing directory 2025/06/23 05:29:15 INFO : nested/sub dir: Removing directory 2025/06/23 05:29:15 INFO : nested: Removing directory 2025/06/23 05:29:15 DEBUG : Local file system at /tmp/rclone1826897293: deleted 3 directories --- PASS: TestMoveWithDeleteEmptySrcDirs (21.74s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:29:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/23 05:29:30 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/06/23 05:29:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:29:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:29:36 DEBUG : nested/sub dir/file: md5 = b4feece1eab0bfa796fd41d1bb6bb59f OK 2025/06/23 05:29:36 INFO : nested/sub dir/file: Copied (new) 2025/06/23 05:29:36 INFO : nested/sub dir/file: Deleted 2025/06/23 05:29:36 DEBUG : sub dir/hello world: md5 = 7183e8be269f4e7631ac593c3c917786 OK 2025/06/23 05:29:36 INFO : sub dir/hello world: Copied (new) 2025/06/23 05:29:36 INFO : sub dir/hello world: Deleted --- PASS: TestMoveWithoutDeleteEmptySrcDirs (26.10s) === RUN TestMoveWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:29:57 DEBUG : existing-b: Need to transfer - File not found at Destination 2025/06/23 05:29:57 DEBUG : existing: Need to transfer - File not found at Destination 2025/06/23 05:29:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:29:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:29:57 DEBUG : existing-b: md5 = 4aaa6f6b933c42e13757208171ac3934 OK 2025/06/23 05:29:57 INFO : existing-b: Copied (new) 2025/06/23 05:29:57 INFO : existing-b: Deleted 2025/06/23 05:30:02 DEBUG : existing: md5 = bfb79f14340c243284d5dddfc94a81a9 OK 2025/06/23 05:30:02 INFO : existing: Copied (new) 2025/06/23 05:30:02 INFO : existing: Deleted 2025/06/23 05:30:02 DEBUG : existing: Destination exists, skipping 2025/06/23 05:30:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:30:02 DEBUG : existing: Not removing source file as destination file exists and --ignore-existing is set 2025/06/23 05:30:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:30:02 INFO : There was nothing to transfer --- PASS: TestMoveWithIgnoreExisting (16.50s) === RUN TestServerSideMove run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:30:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-wivaves1yiba" 2025/06/23 05:30:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wivaves1yiba.bin" 2025/06/23 05:30:13 DEBUG : Swift container crypt path rclone-test-wivaves1yiba.bin: Auto set use_segments_container to true 2025/06/23 05:30:19 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-wivaves1yiba" 2025/06/23 05:30:19 DEBUG : Swift container crypt path rclone-test-wivaves1yiba: Auto set use_segments_container to true 2025/06/23 05:30:25 DEBUG : potato2: md5 = f30dc5e4dad7fbff98023f363d418a64 OK 2025/06/23 05:30:25 DEBUG : empty space: md5 = 7b69e48ae639a80fe51d57f5e7c74a05 OK 2025/06/23 05:30:30 DEBUG : potato3: md5 = 9179d5c29813d0e2dfb6257c3de4c447 OK sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju' -> Encrypted drive 'TestCryptSwift:rclone-test-wivaves1yiba' 2025/06/23 05:30:36 DEBUG : empty space: md5 = 0c9c36f079c84674e91ed93f5aa1e1bb OK 2025/06/23 05:30:37 DEBUG : potato3: md5 = d4c2bd95733bd886332a9d3bd678e9ed OK 2025/06/23 05:30:42 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:30:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wivaves1yiba': Waiting for checks to finish 2025/06/23 05:30:42 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/23 05:30:42 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:30:42 DEBUG : empty space: Unchanged skipping 2025/06/23 05:30:42 INFO : empty space: Deleted 2025/06/23 05:30:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wivaves1yiba': Waiting for transfers to finish 2025/06/23 05:30:48 INFO : potato2: Copied (server-side copy) 2025/06/23 05:30:48 INFO : potato2: Deleted 2025/06/23 05:30:53 INFO : potato3: Copied (server-side copy) 2025/06/23 05:30:58 INFO : potato3: Deleted 2025/06/23 05:30:58 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-diretoh4favi" 2025/06/23 05:30:58 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-diretoh4favi.bin" 2025/06/23 05:30:59 DEBUG : Swift container crypt path rclone-test-diretoh4favi.bin: Auto set use_segments_container to true 2025/06/23 05:31:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-diretoh4favi" 2025/06/23 05:31:04 DEBUG : Swift container crypt path rclone-test-diretoh4favi: Auto set use_segments_container to true 2025/06/23 05:31:10 DEBUG : empty space: Need to transfer - File not found at Destination 2025/06/23 05:31:10 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:31:10 DEBUG : potato3: Need to transfer - File not found at Destination 2025/06/23 05:31:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-diretoh4favi': Waiting for checks to finish 2025/06/23 05:31:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-diretoh4favi': Waiting for transfers to finish 2025/06/23 05:31:15 INFO : empty space: Copied (server-side copy) 2025/06/23 05:31:15 INFO : potato3: Copied (server-side copy) 2025/06/23 05:31:15 INFO : potato3: Deleted 2025/06/23 05:31:20 INFO : potato2: Copied (server-side copy) 2025/06/23 05:31:20 INFO : empty space: Deleted 2025/06/23 05:31:21 INFO : potato2: Deleted 2025/06/23 05:31:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-diretoh4favi': Purge remote 2025/06/23 05:31:26 DEBUG : Waiting for deletions to finish 2025/06/23 05:31:26 INFO : empty space.bin: Deleted 2025/06/23 05:31:26 INFO : potato3.bin: Deleted 2025/06/23 05:31:36 INFO : potato2.bin: Deleted 2025/06/23 05:31:36 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-wivaves1yiba': Purge remote 2025/06/23 05:31:36 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMove (83.44s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:31:36 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-tihomix7vufu" 2025/06/23 05:31:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tihomix7vufu.bin" 2025/06/23 05:31:37 DEBUG : Swift container crypt path rclone-test-tihomix7vufu.bin: Auto set use_segments_container to true 2025/06/23 05:31:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-tihomix7vufu" 2025/06/23 05:31:43 DEBUG : Swift container crypt path rclone-test-tihomix7vufu: Auto set use_segments_container to true 2025/06/23 05:31:48 DEBUG : potato2: md5 = d7ea1761e39b4f91c8b927269538cb48 OK 2025/06/23 05:31:48 DEBUG : empty space: md5 = 7dd557983fab46e466273c6c233fc337 OK 2025/06/23 05:31:54 DEBUG : potato3: md5 = 95907a152a15dd1ceb0acbdf7177464c OK sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju' -> Encrypted drive 'TestCryptSwift:rclone-test-tihomix7vufu' 2025/06/23 05:31:59 DEBUG : empty space: md5 = 40abd5dbd547a0bf07bae93b2478ab15 OK 2025/06/23 05:32:04 DEBUG : potato3: md5 = bd32836da130de9cfecae9b4d3c506af OK 2025/06/23 05:32:05 DEBUG : empty space: Excluded (Size Filter) 2025/06/23 05:32:05 DEBUG : empty space: Excluded 2025/06/23 05:32:05 DEBUG : empty space: Excluded (Size Filter) 2025/06/23 05:32:05 DEBUG : empty space: Excluded 2025/06/23 05:32:05 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:32:05 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/23 05:32:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tihomix7vufu': Waiting for checks to finish 2025/06/23 05:32:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tihomix7vufu': Waiting for transfers to finish 2025/06/23 05:32:20 INFO : potato2: Copied (server-side copy) 2025/06/23 05:32:20 INFO : potato3: Copied (server-side copy) 2025/06/23 05:32:20 INFO : potato2: Deleted 2025/06/23 05:32:25 INFO : potato3: Deleted 2025/06/23 05:32:31 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-baxagev0keso" 2025/06/23 05:32:31 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-baxagev0keso.bin" 2025/06/23 05:32:31 DEBUG : Swift container crypt path rclone-test-baxagev0keso.bin: Auto set use_segments_container to true 2025/06/23 05:32:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-baxagev0keso" 2025/06/23 05:32:37 DEBUG : Swift container crypt path rclone-test-baxagev0keso: Auto set use_segments_container to true 2025/06/23 05:32:42 DEBUG : empty space: Excluded (Size Filter) 2025/06/23 05:32:42 DEBUG : empty space: Excluded 2025/06/23 05:32:42 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:32:42 DEBUG : potato3: Need to transfer - File not found at Destination 2025/06/23 05:32:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-baxagev0keso': Waiting for checks to finish 2025/06/23 05:32:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-baxagev0keso': Waiting for transfers to finish 2025/06/23 05:32:48 INFO : potato3: Copied (server-side copy) 2025/06/23 05:32:53 INFO : potato2: Copied (server-side copy) 2025/06/23 05:32:53 INFO : potato3: Deleted 2025/06/23 05:32:58 INFO : potato2: Deleted 2025/06/23 05:33:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-baxagev0keso': Purge remote 2025/06/23 05:33:08 DEBUG : Waiting for deletions to finish 2025/06/23 05:33:09 INFO : potato3.bin: Deleted 2025/06/23 05:33:19 INFO : potato2.bin: Deleted 2025/06/23 05:33:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-tihomix7vufu': Purge remote 2025/06/23 05:33:19 DEBUG : Waiting for deletions to finish 2025/06/23 05:33:24 INFO : empty space.bin: Deleted --- PASS: TestServerSideMoveWithFilter (108.05s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:33:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-ligenez6vepa" 2025/06/23 05:33:25 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-ligenez6vepa.bin" 2025/06/23 05:33:25 DEBUG : Swift container crypt path rclone-test-ligenez6vepa.bin: Auto set use_segments_container to true 2025/06/23 05:33:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-ligenez6vepa" 2025/06/23 05:33:30 DEBUG : Swift container crypt path rclone-test-ligenez6vepa: Auto set use_segments_container to true 2025/06/23 05:33:36 DEBUG : potato2: md5 = 86159dcf19b05da92aabfe274f80b47a OK 2025/06/23 05:33:36 DEBUG : empty space: md5 = f7e67e07b59c8f17bab71836845ad340 OK 2025/06/23 05:33:42 DEBUG : potato3: md5 = 92f4cc40d671341532af7abf445a73a2 OK 2025/06/23 05:33:42 INFO : tomatoDir: Making directory sync_test.go:1706: Server side move (if possible) Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju' -> Encrypted drive 'TestCryptSwift:rclone-test-ligenez6vepa' 2025/06/23 05:33:48 DEBUG : empty space: md5 = 41af4ec5f894cf09155132571cc371b7 OK 2025/06/23 05:33:48 DEBUG : potato3: md5 = 134494198d9fbd34654dc418ae2005b6 OK 2025/06/23 05:33:48 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:33:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-ligenez6vepa': Waiting for checks to finish 2025/06/23 05:33:48 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/06/23 05:33:48 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:33:48 DEBUG : empty space: Unchanged skipping 2025/06/23 05:33:49 INFO : empty space: Deleted 2025/06/23 05:33:49 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-ligenez6vepa': Waiting for transfers to finish 2025/06/23 05:33:54 INFO : potato3: Copied (server-side copy) 2025/06/23 05:33:55 INFO : potato2: Copied (server-side copy) 2025/06/23 05:33:55 INFO : potato2: Deleted 2025/06/23 05:33:59 INFO : potato3: Deleted 2025/06/23 05:33:59 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-guveruy2ruko" 2025/06/23 05:33:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-guveruy2ruko.bin" 2025/06/23 05:33:59 DEBUG : Swift container crypt path rclone-test-guveruy2ruko.bin: Auto set use_segments_container to true 2025/06/23 05:34:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-guveruy2ruko" 2025/06/23 05:34:05 DEBUG : Swift container crypt path rclone-test-guveruy2ruko: Auto set use_segments_container to true 2025/06/23 05:34:11 INFO : tomatoDir: Making directory 2025/06/23 05:34:11 DEBUG : empty space: Need to transfer - File not found at Destination 2025/06/23 05:34:11 DEBUG : potato2: Need to transfer - File not found at Destination 2025/06/23 05:34:11 DEBUG : potato3: Need to transfer - File not found at Destination 2025/06/23 05:34:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-guveruy2ruko': Waiting for checks to finish 2025/06/23 05:34:11 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-guveruy2ruko': Waiting for transfers to finish 2025/06/23 05:34:17 INFO : potato2: Copied (server-side copy) 2025/06/23 05:34:17 INFO : potato2: Deleted 2025/06/23 05:34:21 INFO : empty space: Copied (server-side copy) 2025/06/23 05:34:22 INFO : potato3: Copied (server-side copy) 2025/06/23 05:34:22 INFO : potato3: Deleted 2025/06/23 05:34:26 INFO : empty space: Deleted 2025/06/23 05:34:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-guveruy2ruko': Purge remote 2025/06/23 05:34:27 DEBUG : Waiting for deletions to finish 2025/06/23 05:34:27 INFO : potato2.bin: Deleted 2025/06/23 05:34:37 INFO : potato3.bin: Deleted 2025/06/23 05:34:37 INFO : empty space.bin: Deleted 2025/06/23 05:34:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-ligenez6vepa': Purge remote 2025/06/23 05:34:37 DEBUG : Waiting for deletions to finish --- PASS: TestServerSideMoveDeleteEmptySourceDirs (73.11s) === RUN TestServerSideMoveOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:34:38 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/rclone-move-test" 2025/06/23 05:34:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-move-test.bin" 2025/06/23 05:34:38 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-move-test.bin: Auto set use_segments_container to true 2025/06/23 05:34:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-move-test" 2025/06/23 05:34:44 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-move-test: Auto set use_segments_container to true 2025/06/23 05:34:49 DEBUG : potato2: md5 = 60eb1864a1845cace782f67b071775b3 OK --- PASS: TestServerSideMoveOverlap (12.36s) === RUN TestSyncOverlap run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:34:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test" 2025/06/23 05:34:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-sync-test.bin" 2025/06/23 05:34:50 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-sync-test.bin: Auto set use_segments_container to true 2025/06/23 05:34:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-sync-test" 2025/06/23 05:34:56 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-sync-test: Auto set use_segments_container to true --- PASS: TestSyncOverlap (11.64s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:35:02 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test" 2025/06/23 05:35:02 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-sync-test.bin" 2025/06/23 05:35:02 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-sync-test.bin: Auto set use_segments_container to true 2025/06/23 05:35:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-sync-test" 2025/06/23 05:35:07 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-sync-test: Auto set use_segments_container to true 2025/06/23 05:35:13 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test-include/layer2" 2025/06/23 05:35:13 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-sync-test-include/layer2.bin" 2025/06/23 05:35:13 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-sync-test-include/layer2.bin: Auto set use_segments_container to true 2025/06/23 05:35:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-sync-test-include/layer2" 2025/06/23 05:35:19 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-sync-test-include/layer2: Auto set use_segments_container to true 2025/06/23 05:35:24 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test-ignore-file" 2025/06/23 05:35:24 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-sync-test-ignore-file.bin" 2025/06/23 05:35:24 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-sync-test-ignore-file.bin: Auto set use_segments_container to true 2025/06/23 05:35:30 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/rclone-sync-test-ignore-file" 2025/06/23 05:35:30 DEBUG : Swift container crypt path rclone-test-yikemok6faju/rclone-sync-test-ignore-file: Auto set use_segments_container to true 2025/06/23 05:35:41 DEBUG : rclone-sync-test-ignore-file/.ignore: md5 = 7d714128b23aa8f13db454490684b514 OK 2025/06/23 05:35:46 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/23 05:35:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test': Waiting for checks to finish 2025/06/23 05:35:46 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test': Waiting for transfers to finish 2025/06/23 05:35:46 DEBUG : Waiting for deletions to finish 2025/06/23 05:35:46 INFO : There was nothing to transfer 2025/06/23 05:35:51 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/23 05:35:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:35:51 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:35:51 DEBUG : Waiting for deletions to finish 2025/06/23 05:35:51 INFO : There was nothing to transfer 2025/06/23 05:35:57 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/23 05:35:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/06/23 05:35:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/06/23 05:35:57 DEBUG : Waiting for deletions to finish 2025/06/23 05:35:57 INFO : There was nothing to transfer 2025/06/23 05:36:08 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/23 05:36:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:36:08 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:36:08 DEBUG : Waiting for deletions to finish 2025/06/23 05:36:08 INFO : There was nothing to transfer 2025/06/23 05:36:13 DEBUG : Excluded 2025/06/23 05:36:18 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/06/23 05:36:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/06/23 05:36:18 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/06/23 05:36:18 DEBUG : Waiting for deletions to finish 2025/06/23 05:36:18 INFO : There was nothing to transfer --- PASS: TestSyncOverlapWithFilter (86.73s) === RUN TestSyncCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:36:28 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/dst" 2025/06/23 05:36:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst.bin" 2025/06/23 05:36:29 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst.bin: Auto set use_segments_container to true 2025/06/23 05:36:34 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst" 2025/06/23 05:36:34 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst: Auto set use_segments_container to true 2025/06/23 05:36:40 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/CompareDest" 2025/06/23 05:36:40 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/CompareDest.bin" 2025/06/23 05:36:40 DEBUG : Swift container crypt path rclone-test-yikemok6faju/CompareDest.bin: Auto set use_segments_container to true 2025/06/23 05:36:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/CompareDest" 2025/06/23 05:36:46 DEBUG : Swift container crypt path rclone-test-yikemok6faju/CompareDest: Auto set use_segments_container to true 2025/06/23 05:36:56 DEBUG : one: Need to transfer - File not found at Destination 2025/06/23 05:36:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:36:56 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:36:57 DEBUG : one: md5 = b5ab5d20b301d5cab451fd1382a063cc OK 2025/06/23 05:36:57 INFO : one: Copied (new) 2025/06/23 05:36:57 DEBUG : Waiting for deletions to finish 2025/06/23 05:36:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:36:57 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/23 05:37:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:37:02 DEBUG : one: md5 = 150cc3863906ad6d209dbf0b20caf3e2 OK 2025/06/23 05:37:02 INFO : one: Copied (replaced existing) 2025/06/23 05:37:02 DEBUG : Waiting for deletions to finish 2025/06/23 05:37:03 DEBUG : dst/one: md5 = d8aee6ab01f8f10370af2508312ce268 OK 2025/06/23 05:37:03 DEBUG : CompareDest/one: md5 = de4155ec8747f4e02a9ac42d2dd90d6b OK 2025/06/23 05:37:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:37:04 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/23 05:37:04 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:37:04 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/23 05:37:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:37:04 DEBUG : Waiting for deletions to finish 2025/06/23 05:37:04 INFO : There was nothing to transfer 2025/06/23 05:37:04 DEBUG : CompareDest/two: md5 = 47bf8eeb4785684aea0e25ecadf34e9d OK 2025/06/23 05:37:04 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/23 05:37:05 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:37:05 DEBUG : two: Destination found in --compare-dest, skipping 2025/06/23 05:37:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:37:05 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:37:05 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/23 05:37:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:37:05 DEBUG : Waiting for deletions to finish 2025/06/23 05:37:05 INFO : There was nothing to transfer 2025/06/23 05:37:05 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/23 05:37:05 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:37:05 DEBUG : two: Destination found in --compare-dest, skipping 2025/06/23 05:37:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:37:05 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:37:05 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/23 05:37:05 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:37:05 DEBUG : Waiting for deletions to finish 2025/06/23 05:37:05 INFO : There was nothing to transfer sync_test.go:2176: No hash on uploaded file so skipping compare timestamp test 2025/06/23 05:37:06 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/23 05:37:06 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:37:06 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/23 05:37:06 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/06/23 05:37:06 DEBUG : two: Need to transfer - File not found at Destination 2025/06/23 05:37:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:37:06 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:37:11 DEBUG : two: md5 = 1eb8bb400d2450885356f6de81b86294 OK 2025/06/23 05:37:11 INFO : two: Copied (new) 2025/06/23 05:37:11 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (53.85s) === RUN TestSyncMultipleCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:37:28 DEBUG : pre-dest1/1: md5 = 95969300a524569d21eddddb174645b9 OK 2025/06/23 05:37:33 DEBUG : pre-dest2/2: md5 = 050151a10da1f26a49a2b67fbfef3db9 OK 2025/06/23 05:37:43 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/dest" 2025/06/23 05:37:44 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dest.bin" 2025/06/23 05:37:44 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dest.bin: Auto set use_segments_container to true 2025/06/23 05:37:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dest" 2025/06/23 05:37:49 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dest: Auto set use_segments_container to true 2025/06/23 05:37:55 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/pre-dest1" 2025/06/23 05:37:55 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/pre-dest1.bin" 2025/06/23 05:37:55 DEBUG : Swift container crypt path rclone-test-yikemok6faju/pre-dest1.bin: Auto set use_segments_container to true 2025/06/23 05:38:00 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/pre-dest1" 2025/06/23 05:38:01 DEBUG : Swift container crypt path rclone-test-yikemok6faju/pre-dest1: Auto set use_segments_container to true 2025/06/23 05:38:06 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/pre-dest2" 2025/06/23 05:38:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/pre-dest2.bin" 2025/06/23 05:38:06 DEBUG : Swift container crypt path rclone-test-yikemok6faju/pre-dest2.bin: Auto set use_segments_container to true 2025/06/23 05:38:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/pre-dest2" 2025/06/23 05:38:12 DEBUG : Swift container crypt path rclone-test-yikemok6faju/pre-dest2: Auto set use_segments_container to true 2025/06/23 05:38:17 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:38:17 DEBUG : 1: Destination found in --compare-dest, skipping 2025/06/23 05:38:27 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:38:27 DEBUG : 2: Destination found in --compare-dest, skipping 2025/06/23 05:38:38 DEBUG : 3: Need to transfer - File not found at Destination 2025/06/23 05:38:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dest': Waiting for checks to finish 2025/06/23 05:38:38 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dest': Waiting for transfers to finish 2025/06/23 05:38:44 DEBUG : 3: md5 = d8f24ad8dfcbd3647bb8c9325f535518 OK 2025/06/23 05:38:44 INFO : 3: Copied (new) 2025/06/23 05:38:44 DEBUG : Waiting for deletions to finish --- PASS: TestSyncMultipleCompareDest (102.94s) === RUN TestSyncCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:39:05 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/dst" 2025/06/23 05:39:05 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst.bin" 2025/06/23 05:39:06 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst.bin: Auto set use_segments_container to true 2025/06/23 05:39:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst" 2025/06/23 05:39:11 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst: Auto set use_segments_container to true 2025/06/23 05:39:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/CopyDest" 2025/06/23 05:39:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/CopyDest.bin" 2025/06/23 05:39:17 DEBUG : Swift container crypt path rclone-test-yikemok6faju/CopyDest.bin: Auto set use_segments_container to true 2025/06/23 05:39:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/CopyDest" 2025/06/23 05:39:22 DEBUG : Swift container crypt path rclone-test-yikemok6faju/CopyDest: Auto set use_segments_container to true 2025/06/23 05:39:33 DEBUG : one: Need to transfer - File not found at Destination 2025/06/23 05:39:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:39:33 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:39:33 DEBUG : one: md5 = 374d43109b0def8e28a0430783fc7be6 OK 2025/06/23 05:39:33 INFO : one: Copied (new) 2025/06/23 05:39:33 DEBUG : Waiting for deletions to finish 2025/06/23 05:39:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:39:34 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/23 05:39:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:39:39 DEBUG : one: md5 = 2f3ccd8609b778459863c9dc5853b607 OK 2025/06/23 05:39:39 INFO : one: Copied (replaced existing) 2025/06/23 05:39:39 DEBUG : Waiting for deletions to finish 2025/06/23 05:39:39 DEBUG : dst/one: md5 = a1559ebfda5c0f502f63cd76cb8a4a12 OK 2025/06/23 05:39:45 DEBUG : CopyDest/one: md5 = 42d7634346593f3a798124070c8aadd4 OK 2025/06/23 05:39:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/BackupDir" 2025/06/23 05:39:50 DEBUG : Config file has changed externally - reloading 2025/06/23 05:39:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/BackupDir.bin" 2025/06/23 05:39:50 DEBUG : Swift container crypt path rclone-test-yikemok6faju/BackupDir.bin: Auto set use_segments_container to true 2025/06/23 05:39:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/BackupDir" 2025/06/23 05:39:56 DEBUG : Swift container crypt path rclone-test-yikemok6faju/BackupDir: Auto set use_segments_container to true 2025/06/23 05:40:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/23 05:40:02 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:40:02 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:40:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/23 05:40:18 INFO : one: Copied (server-side copy) 2025/06/23 05:40:18 INFO : one: Deleted 2025/06/23 05:40:23 INFO : one: Copied (server-side copy) 2025/06/23 05:40:23 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/06/23 05:40:23 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:40:23 DEBUG : Waiting for deletions to finish 2025/06/23 05:40:34 DEBUG : CopyDest/two: md5 = 824004b4bbeddf65b40df69c71a30ea4 OK 2025/06/23 05:40:44 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:40:44 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:40:44 DEBUG : one: Unchanged skipping 2025/06/23 05:41:44 INFO : two: Copied (server-side copy) 2025/06/23 05:41:44 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/06/23 05:41:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:41:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:41:44 DEBUG : Waiting for deletions to finish 2025/06/23 05:41:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:41:50 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:41:50 DEBUG : one: Unchanged skipping 2025/06/23 05:42:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:42:10 DEBUG : two: Unchanged skipping 2025/06/23 05:42:10 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:42:10 DEBUG : Waiting for deletions to finish 2025/06/23 05:42:10 INFO : There was nothing to transfer 2025/06/23 05:42:26 DEBUG : CopyDest/three: md5 = c366a55fb5a0616a469b4bc42b557ae1 OK 2025/06/23 05:42:26 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/06/23 05:42:26 DEBUG : three: Destination not found in --copy-dest 2025/06/23 05:42:26 DEBUG : three: Need to transfer - File not found at Destination 2025/06/23 05:42:26 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:42:26 DEBUG : one: Unchanged skipping 2025/06/23 05:42:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:42:26 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:42:26 DEBUG : two: Unchanged skipping 2025/06/23 05:42:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:42:26 DEBUG : three: md5 = 823a433566c835477af9e57d8a1eaa41 OK 2025/06/23 05:42:26 INFO : three: Copied (new) 2025/06/23 05:42:26 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (228.05s) === RUN TestSyncBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:42:53 DEBUG : dst/one: md5 = a3eef465c1e548048a4f1eef17adf906 OK 2025/06/23 05:42:58 DEBUG : dst/two: md5 = 29e37adbb3956ec3b5d42047c4c23fcf OK 2025/06/23 05:43:04 DEBUG : dst/three.txt: md5 = 39404744d7ecda6c07c06ed9ae3e28dd OK 2025/06/23 05:43:04 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/dst" 2025/06/23 05:43:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst.bin" 2025/06/23 05:43:04 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst.bin: Auto set use_segments_container to true 2025/06/23 05:43:10 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst" 2025/06/23 05:43:10 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst: Auto set use_segments_container to true 2025/06/23 05:43:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/backup" 2025/06/23 05:43:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/backup.bin" 2025/06/23 05:43:15 DEBUG : Swift container crypt path rclone-test-yikemok6faju/backup.bin: Auto set use_segments_container to true 2025/06/23 05:43:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/backup" 2025/06/23 05:43:21 DEBUG : Swift container crypt path rclone-test-yikemok6faju/backup: Auto set use_segments_container to true 2025/06/23 05:43:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/23 05:43:32 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:43:37 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:43:37 DEBUG : two: Unchanged skipping 2025/06/23 05:43:42 INFO : one: Copied (server-side copy) 2025/06/23 05:43:42 INFO : one: Deleted 2025/06/23 05:43:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:43:42 DEBUG : one: md5 = d15d47ef5f537f82ce3878ac230f4709 OK 2025/06/23 05:43:42 INFO : one: Copied (new) 2025/06/23 05:43:42 DEBUG : Waiting for deletions to finish 2025/06/23 05:43:58 INFO : three.txt: Copied (server-side copy) 2025/06/23 05:44:03 INFO : three.txt: Deleted 2025/06/23 05:44:03 INFO : three.txt: Moved into backup dir 2025/06/23 05:44:13 DEBUG : dst/three.txt: md5 = fa22c980fb0501630f61d0a158d40ebc OK 2025/06/23 05:44:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:44:14 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/23 05:44:19 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:44:19 DEBUG : two: Unchanged skipping 2025/06/23 05:44:19 INFO : one: Copied (server-side copy) 2025/06/23 05:44:19 INFO : one: Deleted 2025/06/23 05:44:19 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:44:19 DEBUG : one: md5 = c66f3ba3813c22d191dfd4e6fc49317a OK 2025/06/23 05:44:19 INFO : one: Copied (new) 2025/06/23 05:44:19 DEBUG : Waiting for deletions to finish 2025/06/23 05:44:30 INFO : three.txt: Copied (server-side copy) 2025/06/23 05:44:35 INFO : three.txt: Deleted 2025/06/23 05:44:35 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (127.73s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:45:01 DEBUG : dst/one: md5 = aacd276484e7091b4023613151e2bdc7 OK 2025/06/23 05:45:06 DEBUG : dst/two: md5 = 024a8a6113fb4e8ad3e736ccb15d1def OK 2025/06/23 05:45:11 DEBUG : dst/three.txt: md5 = 25b0c724a84416e642264f6450c3aecc OK 2025/06/23 05:45:12 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/dst" 2025/06/23 05:45:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst.bin" 2025/06/23 05:45:12 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst.bin: Auto set use_segments_container to true 2025/06/23 05:45:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst" 2025/06/23 05:45:17 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst: Auto set use_segments_container to true 2025/06/23 05:45:23 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/backup" 2025/06/23 05:45:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/backup.bin" 2025/06/23 05:45:23 DEBUG : Swift container crypt path rclone-test-yikemok6faju/backup.bin: Auto set use_segments_container to true 2025/06/23 05:45:28 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/backup" 2025/06/23 05:45:29 DEBUG : Swift container crypt path rclone-test-yikemok6faju/backup: Auto set use_segments_container to true 2025/06/23 05:45:39 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/23 05:45:39 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:45:39 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:45:39 DEBUG : two: Unchanged skipping 2025/06/23 05:46:00 INFO : one: Copied (server-side copy) to: one.bak 2025/06/23 05:46:00 INFO : one: Deleted 2025/06/23 05:46:00 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:46:00 DEBUG : one: md5 = 2b305d44128bff30754d0f9d26171046 OK 2025/06/23 05:46:00 INFO : one: Copied (new) 2025/06/23 05:46:00 DEBUG : Waiting for deletions to finish 2025/06/23 05:46:20 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/23 05:46:26 INFO : three.txt: Deleted 2025/06/23 05:46:26 INFO : three.txt: Moved into backup dir 2025/06/23 05:46:41 DEBUG : dst/three.txt: md5 = 2db45fe6c5ccefa8fce14f4b5ef806d7 OK 2025/06/23 05:46:52 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/23 05:46:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:46:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:46:52 DEBUG : two: Unchanged skipping 2025/06/23 05:47:12 INFO : one: Copied (server-side copy) to: one.bak 2025/06/23 05:47:12 INFO : one: Deleted 2025/06/23 05:47:12 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:47:12 DEBUG : one: md5 = ee0710e9fbbf2e343de9512118be475e OK 2025/06/23 05:47:12 INFO : one: Copied (new) 2025/06/23 05:47:12 DEBUG : Waiting for deletions to finish 2025/06/23 05:47:27 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/23 05:47:33 INFO : three.txt: Deleted 2025/06/23 05:47:33 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (183.24s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:48:04 DEBUG : dst/one: md5 = a4382067e41124ad43c2120e0e142df8 OK 2025/06/23 05:48:10 DEBUG : dst/two: md5 = 80ddb568048bf2f1bc8c0834f7079f07 OK 2025/06/23 05:48:15 DEBUG : dst/three.txt: md5 = ca78e44d90d970053b4877b4f21021cd OK 2025/06/23 05:48:15 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/dst" 2025/06/23 05:48:15 DEBUG : Config file has changed externally - reloading 2025/06/23 05:48:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst.bin" 2025/06/23 05:48:15 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst.bin: Auto set use_segments_container to true 2025/06/23 05:48:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst" 2025/06/23 05:48:21 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst: Auto set use_segments_container to true 2025/06/23 05:48:26 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/backup" 2025/06/23 05:48:26 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/backup.bin" 2025/06/23 05:48:26 DEBUG : Swift container crypt path rclone-test-yikemok6faju/backup.bin: Auto set use_segments_container to true 2025/06/23 05:48:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/backup" 2025/06/23 05:48:32 DEBUG : Swift container crypt path rclone-test-yikemok6faju/backup: Auto set use_segments_container to true 2025/06/23 05:48:42 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/23 05:48:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:48:47 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:48:47 DEBUG : two: Unchanged skipping 2025/06/23 05:48:53 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/06/23 05:48:53 INFO : one: Deleted 2025/06/23 05:48:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:48:53 DEBUG : one: md5 = 297df5d3cfc02b771bfd5e4dcb1f55af OK 2025/06/23 05:48:53 INFO : one: Copied (new) 2025/06/23 05:48:53 DEBUG : Waiting for deletions to finish 2025/06/23 05:49:09 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/06/23 05:49:14 INFO : three.txt: Deleted 2025/06/23 05:49:14 INFO : three.txt: Moved into backup dir 2025/06/23 05:49:20 DEBUG : dst/three.txt: md5 = 4e7fd4770fa13213ad2c820452b07905 OK 2025/06/23 05:49:25 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/23 05:49:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:49:30 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:49:30 DEBUG : two: Unchanged skipping 2025/06/23 05:49:31 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/06/23 05:49:31 INFO : one: Deleted 2025/06/23 05:49:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:49:31 DEBUG : one: md5 = c164b6354542731d86b4a7bce052efcd OK 2025/06/23 05:49:31 INFO : one: Copied (new) 2025/06/23 05:49:31 DEBUG : Waiting for deletions to finish 2025/06/23 05:49:46 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/06/23 05:49:52 INFO : three.txt: Deleted 2025/06/23 05:49:52 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (123.35s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:50:08 DEBUG : dst/one: md5 = 3da8dd6c952652da9cea2810a3126986 OK 2025/06/23 05:50:13 DEBUG : dst/two: md5 = 3bdcd266fec7f68483d3a7fddbd8433e OK 2025/06/23 05:50:18 DEBUG : dst/three.txt: md5 = cabe98e8e68e37125a73ab2678ccf3fd OK 2025/06/23 05:50:23 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/dst" 2025/06/23 05:50:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst.bin" 2025/06/23 05:50:24 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst.bin: Auto set use_segments_container to true 2025/06/23 05:50:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst" 2025/06/23 05:50:29 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst: Auto set use_segments_container to true 2025/06/23 05:50:34 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/23 05:50:34 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:50:34 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:50:34 DEBUG : two: Unchanged skipping 2025/06/23 05:50:55 INFO : one: Copied (server-side copy) to: one.bak 2025/06/23 05:50:55 INFO : one: Deleted 2025/06/23 05:50:55 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:50:55 DEBUG : one: md5 = 7691460de434c2589fb03e31a0de5ffc OK 2025/06/23 05:50:55 INFO : one: Copied (new) 2025/06/23 05:50:55 DEBUG : Waiting for deletions to finish 2025/06/23 05:51:16 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/23 05:51:21 INFO : three.txt: Deleted 2025/06/23 05:51:21 INFO : three.txt: Moved into backup dir 2025/06/23 05:51:26 DEBUG : dst/three.txt: md5 = 83b2b1ca625074c76915e23cfbb4f6e9 OK 2025/06/23 05:51:37 DEBUG : one.bak: Excluded (Path Filter) 2025/06/23 05:51:37 DEBUG : one.bak: Excluded 2025/06/23 05:51:37 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/06/23 05:51:37 DEBUG : three.txt.bak: Excluded 2025/06/23 05:51:37 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/23 05:51:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for checks to finish 2025/06/23 05:51:37 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:51:37 DEBUG : two: Unchanged skipping 2025/06/23 05:51:48 INFO : one: Copied (server-side copy) to: one.bak 2025/06/23 05:51:48 INFO : one: Deleted 2025/06/23 05:51:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju/dst': Waiting for transfers to finish 2025/06/23 05:51:48 DEBUG : one: md5 = 63d45097b86e5b09aa306d48b3a30391 OK 2025/06/23 05:51:48 INFO : one: Copied (new) 2025/06/23 05:51:48 DEBUG : Waiting for deletions to finish 2025/06/23 05:52:03 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/23 05:52:09 INFO : three.txt: Deleted 2025/06/23 05:52:09 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (147.21s) === RUN TestSyncSuffix run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:52:35 DEBUG : dst/one: md5 = af559007fc8e6fc30b0cd3f9771e5ef4 OK 2025/06/23 05:52:40 DEBUG : dst/two: md5 = 3222ad666421eae732e278d5813bdeb7 OK 2025/06/23 05:52:45 DEBUG : dst/three.txt: md5 = a13e8a15694da46629948a6a982618be OK 2025/06/23 05:52:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/dst" 2025/06/23 05:52:50 DEBUG : Config file has changed externally - reloading 2025/06/23 05:52:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst.bin" 2025/06/23 05:52:51 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst.bin: Auto set use_segments_container to true 2025/06/23 05:52:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst" 2025/06/23 05:52:56 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst: Auto set use_segments_container to true 2025/06/23 05:53:17 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/23 05:53:32 INFO : one: Copied (server-side copy) to: one.bak 2025/06/23 05:53:32 INFO : one: Deleted 2025/06/23 05:53:32 DEBUG : one: md5 = 8ed62ca8dc0061c7dbe7eefe7c344676 OK 2025/06/23 05:53:32 INFO : one: Copied (new) 2025/06/23 05:53:37 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:53:37 DEBUG : two: Unchanged skipping 2025/06/23 05:53:42 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/06/23 05:53:58 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/23 05:54:03 INFO : three.txt: Deleted 2025/06/23 05:54:08 DEBUG : three.txt: md5 = 37a5c3a932c2ad245ba59b8edb13f5d7 OK 2025/06/23 05:54:08 INFO : three.txt: Copied (new) 2025/06/23 05:54:19 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/23 05:54:34 INFO : one: Copied (server-side copy) to: one.bak 2025/06/23 05:54:34 INFO : one: Deleted 2025/06/23 05:54:35 DEBUG : one: md5 = ac7d2db98c41b1cee208b0e47dcbb5b3 OK 2025/06/23 05:54:35 INFO : one: Copied (new) 2025/06/23 05:54:35 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:54:35 DEBUG : two: Unchanged skipping 2025/06/23 05:54:35 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/06/23 05:54:45 INFO : three.txt: Copied (server-side copy) to: three.txt.bak 2025/06/23 05:54:50 INFO : three.txt: Deleted 2025/06/23 05:54:55 DEBUG : three.txt: md5 = 83f3e4bdca4421ce5bf70b5ab96a20e9 OK 2025/06/23 05:54:55 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (176.53s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:55:31 DEBUG : dst/one: md5 = 8a0b299be00c01a42ab786989bb6e449 OK 2025/06/23 05:55:36 DEBUG : dst/two: md5 = 901a4d1514bd4747140c9637341db1f6 OK 2025/06/23 05:55:42 DEBUG : dst/three.txt: md5 = 39770737ce58c989d11ae66557b7632b OK 2025/06/23 05:55:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yikemok6faju/dst" 2025/06/23 05:55:42 DEBUG : Config file has changed externally - reloading 2025/06/23 05:55:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst.bin" 2025/06/23 05:55:43 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst.bin: Auto set use_segments_container to true 2025/06/23 05:55:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yikemok6faju/dst" 2025/06/23 05:55:48 DEBUG : Swift container crypt path rclone-test-yikemok6faju/dst: Auto set use_segments_container to true 2025/06/23 05:55:54 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/06/23 05:56:15 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/06/23 05:56:15 INFO : one: Deleted 2025/06/23 05:56:15 DEBUG : one: md5 = e735050f28f2dfc4842f7c4b95331dca OK 2025/06/23 05:56:15 INFO : one: Copied (new) 2025/06/23 05:56:15 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:56:15 DEBUG : two: Unchanged skipping 2025/06/23 05:56:20 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/06/23 05:56:36 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/06/23 05:56:41 INFO : three.txt: Deleted 2025/06/23 05:56:46 DEBUG : three.txt: md5 = 29202e41e88502a907fdb84bdbf7a206 OK 2025/06/23 05:56:46 INFO : three.txt: Copied (new) 2025/06/23 05:57:02 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/06/23 05:57:17 INFO : one: Copied (server-side copy) to: one-2019-01-01 2025/06/23 05:57:18 INFO : one: Deleted 2025/06/23 05:57:18 DEBUG : one: md5 = a88dd731971837b1742651a5a2224457 OK 2025/06/23 05:57:18 INFO : one: Copied (new) 2025/06/23 05:57:18 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:57:18 DEBUG : two: Unchanged skipping 2025/06/23 05:57:18 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/06/23 05:57:38 INFO : three.txt: Copied (server-side copy) to: three-2019-01-01.txt 2025/06/23 05:57:43 INFO : three.txt: Deleted 2025/06/23 05:57:49 DEBUG : three.txt: md5 = 1d6f1fb686fe62401c4fd1a1ab20bfa1 OK 2025/06/23 05:57:49 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (169.27s) === RUN TestSyncUTFNorm run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:58:26 DEBUG : Testêé: md5 = 01543302a830202ddbe89b4c1e79a79c OK 2025/06/23 05:58:31 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/06/23 05:58:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:58:31 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:58:42 DEBUG : Testêé: md5 = 4bb492b46b2ab2cf6f41dbe5771e1fbe OK 2025/06/23 05:58:42 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/06/23 05:58:42 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (31.60s) === RUN TestSyncImmutable run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:58:53 DEBUG : existing: Need to transfer - File not found at Destination 2025/06/23 05:58:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:58:53 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:58:58 DEBUG : existing: md5 = d575b8642ad89f4a6fdec356d7a6de25 OK 2025/06/23 05:58:58 INFO : existing: Copied (new) 2025/06/23 05:58:58 DEBUG : Waiting for deletions to finish 2025/06/23 05:59:04 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/06/23 05:59:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:59:04 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/06/23 05:59:04 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:59:04 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': not deleting files as there were IO errors 2025/06/23 05:59:04 ERROR : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': not deleting directories as there were IO errors --- PASS: TestSyncImmutable (27.23s) === RUN TestSyncIgnoreCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:59:20 DEBUG : EXISTING: md5 = f7eb794f30035d1f0d392afddd7967d1 OK 2025/06/23 05:59:20 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 05:59:21 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 05:59:21 DEBUG : existing: Unchanged skipping 2025/06/23 05:59:21 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 05:59:21 DEBUG : Waiting for deletions to finish 2025/06/23 05:59:21 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (1.93s) === RUN TestFixCase run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:2636: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.44s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:2675: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:2675: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" sync_test.go:2675: This test only runs on local --- PASS: TestMaxTransfer (0.29s) --- SKIP: TestMaxTransfer/Hard (0.10s) --- SKIP: TestMaxTransfer/Soft (0.10s) --- SKIP: TestMaxTransfer/Cautious (0.10s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 05:59:27 DEBUG : both0: md5 = e05e7cdae84e59a097e2dca274018211 OK 2025/06/23 05:59:28 DEBUG : only0: md5 = 9bb94b4720990aeaf24d2900115babe6 OK 2025/06/23 05:59:33 DEBUG : both1: md5 = b4eb984d5a9cbdf5a62bfd03b2c09ed7 OK 2025/06/23 05:59:39 DEBUG : only1: md5 = a23ce5f3aa6d726fbde4350ea8515860 OK 2025/06/23 05:59:44 DEBUG : both2: md5 = 7d5c1ec0fc8df6cee55e8ce19b2c7d04 OK 2025/06/23 05:59:50 DEBUG : only2: md5 = 938fcd542ad7743edc837b2c7d499e72 OK 2025/06/23 05:59:50 DEBUG : both3: md5 = 8261a39af079f3cd2decf7c5d443b389 OK 2025/06/23 05:59:56 DEBUG : only3: md5 = 9a3af728d334bb00ace2fe07cf72cd1c OK 2025/06/23 06:00:01 DEBUG : both4: md5 = 4dfd19893bb0a634e74cbaa0c0894ede OK 2025/06/23 06:00:06 DEBUG : only4: md5 = 579ace06faededeeec432111a8e4639c OK 2025/06/23 06:00:11 DEBUG : both5: md5 = fb0320916db16776e33e0232d47fb018 OK 2025/06/23 06:00:12 DEBUG : only5: md5 = 2279815615a21d96397841f700a74e33 OK 2025/06/23 06:00:17 DEBUG : both6: md5 = 497511988b23f1308b04ae80bbf08574 OK 2025/06/23 06:00:22 DEBUG : only6: md5 = 52b500c6a2aba35509d5f2244f28972d OK 2025/06/23 06:00:28 DEBUG : both7: md5 = b6f9da761ce67d79615647dd8a28b78e OK 2025/06/23 06:00:28 DEBUG : only7: md5 = 9cead76681207cba93d7df18636f58e4 OK 2025/06/23 06:00:33 DEBUG : both8: md5 = bb07f9edf15cbee2697cf4e5963ef65c OK 2025/06/23 06:00:33 DEBUG : only8: md5 = 2648768b43230f6da0228bab197cdc1d OK 2025/06/23 06:00:34 DEBUG : both9: md5 = a6df1b324d2bea235b4386f3a9319e8d OK 2025/06/23 06:00:35 DEBUG : only9: md5 = 3712820e986a1b17f2c6c94b89fab80e OK 2025/06/23 06:00:41 DEBUG : both10: md5 = 2b4426b426da531d2cc2227cd1934f0e OK 2025/06/23 06:00:41 DEBUG : only10: md5 = 8db5f69352d575d468c6831965af8196 OK 2025/06/23 06:00:47 DEBUG : both11: md5 = c2d33fee04677b001f931c6a5fb45599 OK 2025/06/23 06:00:52 DEBUG : only11: md5 = 73b9b55c24fd8fb714f874580ffe228b OK 2025/06/23 06:00:52 DEBUG : both12: md5 = 6dc4d766f3a563439139511534fceed5 OK 2025/06/23 06:00:58 DEBUG : only12: md5 = 8ce1a44b363491aca745bd49a58c6a37 OK 2025/06/23 06:01:03 DEBUG : both13: md5 = 493bf998a5ee3a280863ac6085a3fc1f OK 2025/06/23 06:01:04 DEBUG : only13: md5 = 56dcbe1b4f4b8d4ad655334207995437 OK 2025/06/23 06:01:10 DEBUG : both14: md5 = 2fc019d0c035ac624f492f4251ce4b3c OK 2025/06/23 06:01:15 DEBUG : only14: md5 = 73e9418074a03fe5bbacdbedc894c0af OK 2025/06/23 06:01:20 DEBUG : both15: md5 = 0951f679b81a52e069dd4a8af359f1d9 OK 2025/06/23 06:01:25 DEBUG : only15: md5 = f6ca956ae5d3a03d4943cfb79dbf6778 OK 2025/06/23 06:01:31 DEBUG : both16: md5 = e03d583052745d430a4762c52a427845 OK 2025/06/23 06:01:36 DEBUG : only16: md5 = 6b31b0b29b728843a303427c30d0d7b0 OK 2025/06/23 06:01:42 DEBUG : both17: md5 = 456e250309595fba2246bdecf5a1e0c3 OK 2025/06/23 06:01:47 DEBUG : only17: md5 = a93fb1d3337a37eb57ab25505508a82d OK 2025/06/23 06:01:48 DEBUG : both18: md5 = 233bd0268586a61a1c9f69ef4fe54782 OK 2025/06/23 06:01:48 DEBUG : only18: md5 = af048c718766008cdb4a64ebb39bbfb8 OK 2025/06/23 06:01:54 DEBUG : both19: md5 = a84680e2655d45d7a01c1efca9e7a767 OK 2025/06/23 06:01:59 DEBUG : only19: md5 = 61d216aa1f83306cadf370c912b2fa75 OK 2025/06/23 06:02:57 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 06:02:57 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:02:57 DEBUG : both0: Unchanged skipping 2025/06/23 06:02:57 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:02:57 DEBUG : both10: Unchanged skipping 2025/06/23 06:02:57 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:02:57 DEBUG : both12: Unchanged skipping 2025/06/23 06:02:57 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:02:57 DEBUG : both13: Unchanged skipping 2025/06/23 06:02:57 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:02:57 DEBUG : both14: Unchanged skipping 2025/06/23 06:02:57 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:02:57 DEBUG : both15: Unchanged skipping 2025/06/23 06:02:57 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:02:57 DEBUG : both17: Unchanged skipping 2025/06/23 06:02:57 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:02:57 DEBUG : both18: Unchanged skipping 2025/06/23 06:02:57 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:02:57 DEBUG : both19: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both11: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both3: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both4: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both16: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both6: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both1: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both7: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both2: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both8: Unchanged skipping 2025/06/23 06:03:02 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:02 DEBUG : both9: Unchanged skipping 2025/06/23 06:03:07 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:03:07 DEBUG : both5: Unchanged skipping 2025/06/23 06:03:07 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 06:03:07 DEBUG : Waiting for deletions to finish 2025/06/23 06:03:07 INFO : only0: Deleted 2025/06/23 06:03:07 INFO : only13: Deleted 2025/06/23 06:03:07 INFO : only10: Deleted 2025/06/23 06:03:12 INFO : only15: Deleted 2025/06/23 06:03:12 INFO : only3: Deleted 2025/06/23 06:03:13 INFO : only18: Deleted 2025/06/23 06:03:13 INFO : only8: Deleted 2025/06/23 06:03:17 INFO : only14: Deleted 2025/06/23 06:03:17 INFO : only4: Deleted 2025/06/23 06:03:18 INFO : only2: Deleted 2025/06/23 06:03:23 INFO : only12: Deleted 2025/06/23 06:03:23 INFO : only16: Deleted 2025/06/23 06:03:23 INFO : only19: Deleted 2025/06/23 06:03:28 INFO : only1: Deleted 2025/06/23 06:03:28 INFO : only5: Deleted 2025/06/23 06:03:28 INFO : only7: Deleted 2025/06/23 06:03:28 INFO : only11: Deleted 2025/06/23 06:03:28 INFO : only9: Deleted 2025/06/23 06:03:33 INFO : only17: Deleted 2025/06/23 06:03:33 INFO : only6: Deleted 2025/06/23 06:03:33 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (375.46s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 06:05:43 DEBUG : both0: md5 = 791d00a8a4945f1fdb969c967c5f76ce OK 2025/06/23 06:05:43 DEBUG : only0: md5 = 5f972e9c22afde511a4c96794d55385d OK 2025/06/23 06:05:48 DEBUG : both1: md5 = 6b5d20bdfca7805ca8ab57afe49f2c89 OK 2025/06/23 06:05:53 DEBUG : only1: md5 = db162b223fa7931586b98488eca42a0c OK 2025/06/23 06:05:58 DEBUG : both2: md5 = 11de596826fb9648d2619b48d5c2ed4f OK 2025/06/23 06:06:03 DEBUG : only2: md5 = 082479c08efbacfa609ccc60a6c2437a OK 2025/06/23 06:06:04 DEBUG : both3: md5 = 0f0525abc18fd648b24e77077ddcefc0 OK 2025/06/23 06:06:09 DEBUG : only3: md5 = 7074bde9d3ef3ce5203da3e4249ba7ee OK 2025/06/23 06:06:14 DEBUG : both4: md5 = 1cdc4592164f1da8af4bacb770831579 OK 2025/06/23 06:06:19 DEBUG : only4: md5 = 231c02886f8cd86886cea79f9687fe7c OK 2025/06/23 06:06:25 DEBUG : both5: md5 = 98e367fa78a7385692d94d12d0b6bfc8 OK 2025/06/23 06:06:25 DEBUG : only5: md5 = 88c1c8a3c9ae76d25cc455a7bb5d3782 OK 2025/06/23 06:06:30 DEBUG : both6: md5 = 763004519e531e24aea34ecc81392c28 OK 2025/06/23 06:06:35 DEBUG : only6: md5 = 5aaa45726494c0cd7b0332da6fc23313 OK 2025/06/23 06:06:40 DEBUG : both7: md5 = 657e66d61fb004f1298e7b657e387e29 OK 2025/06/23 06:06:40 DEBUG : only7: md5 = ef3c168bcb7c55a6d2219762e6ac5b0a OK 2025/06/23 06:06:46 DEBUG : both8: md5 = d18518a9f36272a455f68e90eabd795f OK 2025/06/23 06:06:46 DEBUG : only8: md5 = eba452e86eb09bb80cae8ef225e8f8f4 OK 2025/06/23 06:06:46 DEBUG : both9: md5 = 3d8b77df67b84b0f52597aedcfb61ec1 OK 2025/06/23 06:06:46 DEBUG : only9: md5 = d96278c514874fc00af50547a0eb7a90 OK 2025/06/23 06:06:52 DEBUG : both10: md5 = 63bfd7e3f5321132939c50b14d37865a OK 2025/06/23 06:06:52 DEBUG : only10: md5 = 669e6d3bdaf78acfe17d6e67a1371a87 OK 2025/06/23 06:06:57 DEBUG : both11: md5 = d2782a90c7a637b3f43b9dcdfc872971 OK 2025/06/23 06:07:02 DEBUG : only11: md5 = 7ab9570152dea936a1b8f178dda4abc3 OK 2025/06/23 06:07:02 DEBUG : both12: md5 = f8b449efaec34fa6c32c36cbb216bf35 OK 2025/06/23 06:07:08 DEBUG : only12: md5 = b2183a678123176d1b11bc86aec8468a OK 2025/06/23 06:07:13 DEBUG : both13: md5 = eaa4f9294a10e0a82d672de9cfd916fe OK 2025/06/23 06:07:13 DEBUG : only13: md5 = e748b5b2991b46012087c873839a26ef OK 2025/06/23 06:07:18 DEBUG : both14: md5 = 44d09fda88e90cbdba2f92361275d2ca OK 2025/06/23 06:07:24 DEBUG : only14: md5 = 36de6ed859147654fbef080fda72b0a5 OK 2025/06/23 06:07:29 DEBUG : both15: md5 = 81e3381ea9c66e4b564afb45223dde0c OK 2025/06/23 06:07:34 DEBUG : only15: md5 = 1fac171e888c7f11719de4fca4d0484f OK 2025/06/23 06:07:39 DEBUG : both16: md5 = 01e6ea1a5c8cb634c00c27e13922ad01 OK 2025/06/23 06:07:44 DEBUG : only16: md5 = a82d6b9735a1fa4fb28dc4d36af40e0f OK 2025/06/23 06:07:49 DEBUG : both17: md5 = fe1f0c7c0643a71166e1ae7c57f77c07 OK 2025/06/23 06:07:54 DEBUG : only17: md5 = dd95ef3b2ab7effe159363e614d0eb35 OK 2025/06/23 06:07:55 DEBUG : both18: md5 = 056d0a28a8d1ea0b5184cecf573feb11 OK 2025/06/23 06:07:55 DEBUG : only18: md5 = a8c434a7e024c8be54221109fabe2dd5 OK 2025/06/23 06:08:00 DEBUG : both19: md5 = 76dc47a8e375c686d7896b8f91e809fa OK 2025/06/23 06:08:05 DEBUG : only19: md5 = f75748f8a95c15f1198eb9f5db3164e6 OK 2025/06/23 06:08:42 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for checks to finish 2025/06/23 06:08:42 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:42 DEBUG : both0: Unchanged skipping 2025/06/23 06:08:42 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:42 DEBUG : both10: Unchanged skipping 2025/06/23 06:08:42 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:42 DEBUG : both12: Unchanged skipping 2025/06/23 06:08:42 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:42 DEBUG : both11: Unchanged skipping 2025/06/23 06:08:42 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:42 DEBUG : both14: Unchanged skipping 2025/06/23 06:08:42 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:42 DEBUG : both13: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both15: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both16: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both17: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both18: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both2: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both3: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both4: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both5: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both6: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both8: Unchanged skipping 2025/06/23 06:08:43 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:43 DEBUG : both9: Unchanged skipping 2025/06/23 06:08:43 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/06/23 06:08:43 DEBUG : only0: md5 = e9ad1779c8221a3096ee5d59b2049332 OK 2025/06/23 06:08:43 INFO : only0: Copied (replaced existing) 2025/06/23 06:08:43 DEBUG : only10: md5 = 4794f4584f32d81996356c0fca7e036a OK 2025/06/23 06:08:43 INFO : only10: Copied (replaced existing) 2025/06/23 06:08:43 DEBUG : only13: md5 = 65626fbc00f054ecb891608a1a9e06f0 OK 2025/06/23 06:08:43 INFO : only13: Copied (replaced existing) 2025/06/23 06:08:48 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:48 DEBUG : both19: Unchanged skipping 2025/06/23 06:08:48 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:48 DEBUG : both1: Unchanged skipping 2025/06/23 06:08:48 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/23 06:08:48 DEBUG : both7: Unchanged skipping 2025/06/23 06:08:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju': Waiting for transfers to finish 2025/06/23 06:08:49 DEBUG : only15: md5 = 49bf4a31f03147da4398c1500b989926 OK 2025/06/23 06:08:49 INFO : only15: Copied (replaced existing) 2025/06/23 06:08:53 DEBUG : only11: md5 = 44c8bc51dfb95066b03834e0f452dc57 OK 2025/06/23 06:08:53 INFO : only11: Copied (replaced existing) 2025/06/23 06:08:53 DEBUG : only12: md5 = 78086fc0ed27427de48036e99d5ed4ad OK 2025/06/23 06:08:53 INFO : only12: Copied (replaced existing) 2025/06/23 06:08:53 DEBUG : only18: md5 = 0872967263fd549735dd2c25ebf59aa8 OK 2025/06/23 06:08:53 INFO : only18: Copied (replaced existing) 2025/06/23 06:08:53 DEBUG : only14: md5 = f35b9723944f6621931c53c77025f697 OK 2025/06/23 06:08:53 INFO : only14: Copied (replaced existing) 2025/06/23 06:08:58 DEBUG : only17: md5 = fcf20ce75ca961e3f562d01b4fa9894f OK 2025/06/23 06:08:58 INFO : only17: Copied (replaced existing) 2025/06/23 06:08:58 DEBUG : only19: md5 = e60718e9243b5ea7f658b05affe8e9cf OK 2025/06/23 06:08:58 INFO : only19: Copied (replaced existing) 2025/06/23 06:08:58 DEBUG : only1: md5 = 0a82484d147ad77fa3dbbdf74b4bcbed OK 2025/06/23 06:08:58 INFO : only1: Copied (replaced existing) 2025/06/23 06:08:59 DEBUG : only16: md5 = fb21281595a74703956aca8a0fc4861c OK 2025/06/23 06:08:59 INFO : only16: Copied (replaced existing) 2025/06/23 06:08:59 DEBUG : only5: md5 = c68841e130450ed093f316e5a6a79c8b OK 2025/06/23 06:08:59 INFO : only5: Copied (replaced existing) 2025/06/23 06:09:03 DEBUG : only2: md5 = e219ca811269c9ea0832e17618ea6eb5 OK 2025/06/23 06:09:03 INFO : only2: Copied (replaced existing) 2025/06/23 06:09:04 DEBUG : only7: md5 = 637664c2146aca071002f228a0d7ec5f OK 2025/06/23 06:09:04 INFO : only7: Copied (replaced existing) 2025/06/23 06:09:04 DEBUG : only8: md5 = 80f2213e8b987064ad1d22409e49184f OK 2025/06/23 06:09:04 INFO : only8: Copied (replaced existing) 2025/06/23 06:09:04 DEBUG : only9: md5 = 95f562840c36a29f58c9dd47763cab33 OK 2025/06/23 06:09:04 INFO : only9: Copied (replaced existing) 2025/06/23 06:09:09 DEBUG : only4: md5 = f1ead9fe0e020a95f92d2667862b4903 OK 2025/06/23 06:09:09 INFO : only4: Copied (replaced existing) 2025/06/23 06:09:09 DEBUG : only3: md5 = 22cc3133ca11024885fe8448305a7d16 OK 2025/06/23 06:09:09 INFO : only3: Copied (replaced existing) 2025/06/23 06:09:09 DEBUG : only6: md5 = e7df1ca485d4a1aef9adf20dba09cf79 OK 2025/06/23 06:09:09 INFO : only6: Copied (replaced existing) 2025/06/23 06:09:09 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (420.39s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 06:12:38 DEBUG : empty_dir: Making directory with metadata 2025/06/23 06:12:38 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/23 06:12:38 DEBUG : empty_on_remote: Making directory with metadata 2025/06/23 06:12:38 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/23 06:12:38 INFO : empty_on_remote: Making directory 2025/06/23 06:12:38 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2025/06/23 06:12:43 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/06/23 06:12:43 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/06/23 06:12:43 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/06/23 06:12:43 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) --- PASS: TestSyncReplaceDirModTime (17.08s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 06:12:55 DEBUG : empty_dir: Making directory with metadata 2025/06/23 06:12:55 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/23 06:12:55 DEBUG : empty_on_remote: Making directory with metadata 2025/06/23 06:12:55 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/23 06:12:55 INFO : empty_on_remote: Making directory 2025/06/23 06:12:55 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2025/06/23 06:13:00 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/06/23 06:13:00 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/06/23 06:13:00 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/06/23 06:13:00 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/06/23 06:13:00 INFO : empty_dir: Set directory modification time (using DirSetModTime) --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (11.97s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 06:13:07 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/23 06:13:07 INFO : sub dir: Making directory 2025/06/23 06:13:07 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC --- PASS: TestNothingToTransferWithEmptyDirs (32.55s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yikemok6faju'", Local "Local file system at /tmp/rclone1826897293", Modify Window "1ns" 2025/06/23 06:13:39 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/23 06:13:39 INFO : sub dir: Making directory 2025/06/23 06:13:39 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC panic: test timed out after 1h0m0s running tests: TestNothingToTransferWithoutEmptyDirs (21s) goroutine 14070 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:2484 +0x394 created by time.goFunc /usr/local/go/src/time/sleep.go:215 +0x2d goroutine 1 [chan receive]: testing.(*T).Run(0xc001b10000, {0x26eac16?, 0xc000669ad8?}, 0x27c1838) /usr/local/go/src/testing/testing.go:1859 +0x431 testing.runTests.func1(0xc001b10000) /usr/local/go/src/testing/testing.go:2279 +0x37 testing.tRunner(0xc001b10000, 0xc000669c18) /usr/local/go/src/testing/testing.go:1792 +0xf4 testing.runTests(0xc0019c7ef0, {0x3e7e5e0, 0x6b, 0x6b}, {0xedfead999?, 0x3e945a0?, 0x3e945a0?}) /usr/local/go/src/testing/testing.go:2277 +0x4b4 testing.(*M).Run(0xc000651720) /usr/local/go/src/testing/testing.go:2142 +0x64a github.com/rclone/rclone/fstest.TestMain(0xc000651720) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:69 +0xa5 github.com/rclone/rclone/fs/sync.TestMain(...) /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:45 main.main() _testmain.go:259 +0xa9 goroutine 36 [syscall, 60 minutes]: os/signal.signal_recv() /usr/local/go/src/runtime/sigqueue.go:152 +0x29 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:23 +0x13 created by os/signal.Notify.func1.1 in goroutine 1 /usr/local/go/src/os/signal/signal.go:152 +0x1f goroutine 37 [chan receive, 60 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 13787 [select]: github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc001a961e0, 0xc000443b20, 0xc00196c3c0) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115 github.com/ncw/swift/v2.(*Connection).Call(0xc001a961e0, {0x2af4b08, 0x3eb7b60}, {0xc0003c8960, 0x4f}, {{0xc000a7c200, 0x5}, {0xc000a7c206, 0x30}, {0x267ad24, ...}, ...}) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6 github.com/ncw/swift/v2.(*Connection).storage(0xc001a961e0, {0x2af4b08, 0x3eb7b60}, {{0xc000a7c200, 0x5}, {0xc000a7c206, 0x30}, {0x267ad24, 0x4}, 0x0, ...}) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:847 +0x151 github.com/ncw/swift/v2.(*Connection).objectBase(0x7d9e94581cf8?, {0x2af4b08?, 0x3eb7b60?}, {0xc000a7c200?, 0xc?}, {0xc000a7c206, 0x30}) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2143 +0xf8 github.com/rclone/rclone/backend/swift.(*Object).readMetaData.func1.(*Connection).Object.1() /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2132 +0x85 github.com/ncw/swift/v2.withLORetry(0x0, 0xc000b8b420) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/largeobjects.go:303 +0x9f github.com/ncw/swift/v2.(*Connection).Object(...) /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2131 github.com/rclone/rclone/backend/swift.(*Object).readMetaData.func1() /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1334 +0x156 github.com/rclone/rclone/fs.pacerInvoker(0x1, 0xa, 0xc000688808?) /home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32 github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc001a51680, 0xc001df2960, 0xa) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:197 +0x7c github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc001a51680, 0xc001df2960) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93 github.com/rclone/rclone/backend/swift.(*Object).readMetaData(0xc001df28a0, {0x2af4b08, 0x3eb7b60}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1333 +0x165 github.com/rclone/rclone/backend/swift.(*Object).hasHeader(0xc001df28a0, {0x2af4b08?, 0x3eb7b60?}, {0x26af664, 0x15}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1246 +0x30 github.com/rclone/rclone/backend/swift.(*Object).isLargeObject(0xc001df28a0, {0x2af4b08, 0x3eb7b60}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1277 +0x48 github.com/rclone/rclone/backend/swift.(*Object).Remove(0xc001df28a0, {0x2af4b08, 0x3eb7b60}) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1597 +0x96 github.com/rclone/rclone/fstest.newRunIndividual.func1.1.1() /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x24 github.com/rclone/rclone/fstest.retry(0xc001d081c0, {0xc00234a2a0, 0x23}, 0xc000b8b8c8) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:121 +0xde github.com/rclone/rclone/fstest.newRunIndividual.func1.1({0xc0002e22c0?, 0xc0002e22c0?, 0x1e03394?}) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x29a github.com/rclone/rclone/fs/walk.listR.func1({0xc0002e22c0, 0x2, 0x2}) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:331 +0x1ca github.com/rclone/rclone/backend/crypt.(*Fs).ListR.func1({0xc0002e22c0?, 0xc0022d41e0?, 0x5?}) /home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:481 +0x5b github.com/rclone/rclone/fs/list.(*Helper).send(...) /home/rclone/go/src/github.com/rclone/rclone/fs/list/helpers.go:29 github.com/rclone/rclone/fs/list.(*Helper).Flush(0xc000b8bb30) /home/rclone/go/src/github.com/rclone/rclone/fs/list/helpers.go:47 +0x35 github.com/rclone/rclone/backend/swift.(*Fs).ListR(0xc0018d3c00, {0x2af4b08, 0x3eb7b60}, {0x0?, 0x2416cc0?}, 0xc000513680) /home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:881 +0x185 github.com/rclone/rclone/backend/crypt.(*Fs).ListR(0xc001a09e10, {0x2af4b08, 0x3eb7b60}, {0x0, 0x0}, 0xc0019d61e0) /home/rclone/go/src/github.com/rclone/rclone/backend/crypt/crypt.go:476 +0x118 github.com/rclone/rclone/fs/walk.listR({0x2af4b08, 0x3eb7b60}, {0x2b09280, 0xc001a09e10}, {0x0, 0x0}, 0x1, 0x3, 0xc0005134d0, 0xc0019c7b18, ...) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:299 +0x292 github.com/rclone/rclone/fs/walk.ListR({0x2af4b08, 0x3eb7b60}, {0x2b09280, 0xc001a09e10}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc0005134d0) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:163 +0x1d5 github.com/rclone/rclone/fstest.newRunIndividual.func1() /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:150 +0x107 github.com/rclone/rclone/fstest.(*Run).Finalise(0xc0003fa0e0) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 +0x1c testing.(*common).Cleanup.func1() /usr/local/go/src/testing/testing.go:1211 +0x106 testing.(*common).runCleanup(0xc001d081c0, 0x4b6b00?) /usr/local/go/src/testing/testing.go:1445 +0xea testing.tRunner.func2() /usr/local/go/src/testing/testing.go:1786 +0x25 testing.tRunner(0xc001d081c0, 0x27c1838) /usr/local/go/src/testing/testing.go:1798 +0x11e created by testing.(*T).Run in goroutine 1 /usr/local/go/src/testing/testing.go:1851 +0x413 goroutine 13141 [select]: net/http.(*persistConn).writeLoop(0xc000c586c0) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13126 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 13915 [select]: github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc001a965a0, {0x2af4be8, 0xc0003a3220}) /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145 created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 13787 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x117 goroutine 14069 [select]: net/http.(*persistConn).roundTrip(0xc00087d8c0, 0xc000714190) /usr/local/go/src/net/http/transport.go:2826 +0x785 net/http.(*Transport).roundTrip(0xc000752340, 0xc00196c3c0) /usr/local/go/src/net/http/transport.go:696 +0xb9a net/http.(*Transport).RoundTrip(...) /usr/local/go/src/net/http/roundtrip.go:30 github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc00047e070, 0xc00196c3c0) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345 net/http.send(0xc00196c3c0, {0x2acdfc0, 0xc00047e070}, {0x1?, 0x378ea00?, 0x0?}) /usr/local/go/src/net/http/client.go:259 +0x5e2 net/http.(*Client).send(0xc001a864b0, 0xc00196c3c0, {0x1?, 0x1?, 0x0?}) /usr/local/go/src/net/http/client.go:180 +0x91 net/http.(*Client).do(0xc001a864b0, 0xc00196c3c0) /usr/local/go/src/net/http/client.go:728 +0x989 net/http.(*Client).Do(...) /usr/local/go/src/net/http/client.go:587 github.com/ncw/swift/v2.(*Connection).doTimeoutRequest.func1() /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:421 +0x2b created by github.com/ncw/swift/v2.(*Connection).doTimeoutRequest in goroutine 13787 /home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8 goroutine 2074 [chan receive, 54 minutes]: github.com/rclone/rclone/lib/atexit.Register.func1.1() /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:45 +0x29 created by github.com/rclone/rclone/lib/atexit.Register.func1 in goroutine 2055 /home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68 goroutine 12554 [IO wait]: internal/poll.runtime_pollWait(0x7d9ede278160, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0008fc100?, 0xc0007f3500?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0008fc100, {0xc0007f3500, 0x3500, 0x3500}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0008fc100, {0xc0007f3500?, 0x34f3?, 0xc00011cb80?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc001a94048, {0xc0007f3500?, 0xc0001ff350?, 0xd?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0003c29a8, {0xc0007f3500?, 0x7d9e94f1ede8?, 0x7d9ede61ef30?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc000700378, {0xc0007f3500?, 0x34f3?, 0xc00098f9d0?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0001ff438, {0x2acf520, 0xc000700378}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc0001ff188, {0x7d9e9455c040, 0xc0003c29a8}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc0001ff188, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc0001ff188, {0xc000903000, 0x1000, 0xc0004faf90?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc00087d8c0, {0xc000903000?, 0x7f4ea5?, 0x2acc440?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc001a51260) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc001a51260, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc00087d8c0) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 12493 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 12555 [select]: net/http.(*persistConn).writeLoop(0xc00087d8c0) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 12493 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 13140 [IO wait]: internal/poll.runtime_pollWait(0x7d9ede2786d8, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc001dde080?, 0xc0001dec80?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc001dde080, {0xc0001dec80, 0x1980, 0x1980}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc001dde080, {0xc0001dec80?, 0x1973?, 0xc00208d9c0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc0003923a0, {0xc0001dec80?, 0xc000397dd0?, 0xd?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0005bbec0, {0xc0001dec80?, 0x7d9e9458ab98?, 0x7d9ede61ea78?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc0019c7620, {0xc0001dec80?, 0x1973?, 0xc00098b9d0?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000397eb8, {0x2acf520, 0xc0019c7620}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000397c08, {0x7d9e9455c040, 0xc0005bbec0}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000397c08, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000397c08, {0xc0004f7000, 0x1000, 0xc0004faf90?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc000c586c0, {0xc0004f7000?, 0x7f4ea5?, 0x2acc440?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc001b8e7e0) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc001b8e7e0, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc000c586c0) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 13126 /usr/local/go/src/net/http/transport.go:1944 +0x174f "./sync.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished ERROR in 1h0m11.312124719s (try 2/5): exit status 2: Failed []