"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestCopyEmptyDirectories|TestSyncCompareDest|TestSyncIgnoreCase|TestSyncWithTrackRenamesStrategyLeaf)$'" - Starting (try 2/5) 2025/06/24 02:42:22 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lacahun1veyu" 2025/06/24 02:42:22 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/24 02:42:22 DEBUG : Creating backend with remote "TestYandex:rclone-test-lacahun1veyu" 2025/06/24 02:42:22 DEBUG : Creating backend with remote "/tmp/rclone2944403158" === RUN TestCopyEmptyDirectories run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu'", Local "Local file system at /tmp/rclone2944403158", Modify Window "1ns" 2025/06/24 02:42:22 DEBUG : sub dir2/sub sub dir2: Making directory with metadata 2025/06/24 02:42:22 INFO : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/06/24 02:42:22 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/06/24 02:42:23 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/06/24 02:42:23 INFO : sub dir2: Making directory 2025/06/24 02:42:24 INFO : sub dir: Making directory 2025/06/24 02:42:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/06/24 02:42:24 INFO : sub dir2/sub sub dir2: Making directory 2025/06/24 02:42:24 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit 2025/06/24 02:42:24 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for checks to finish 2025/06/24 02:42:24 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for transfers to finish 2025/06/24 02:42:29 INFO : sub dir/hello world.rclone_chunk.001_cftael: Moved (server-side) to: sub dir/hello world 2025/06/24 02:42:29 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/06/24 02:42:29 INFO : sub dir/hello world: Copied (new) 2025/06/24 02:42:31 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopyEmptyDirectories (31.33s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu'", Local "Local file system at /tmp/rclone2944403158", Modify Window "1ns" sync_test.go:1650: Can track renames: true 2025/06/24 02:42:54 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Making map for --track-renames 2025/06/24 02:42:54 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Finished making map for --track-renames 2025/06/24 02:42:54 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for checks to finish 2025/06/24 02:42:54 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/06/24 02:42:54 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for renames to finish 2025/06/24 02:42:54 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/06/24 02:42:54 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for transfers to finish 2025/06/24 02:42:54 DEBUG : sub/yam: skip slow MD5 on source file, hashing in-transit 2025/06/24 02:42:54 DEBUG : potato: skip slow MD5 on source file, hashing in-transit 2025/06/24 02:42:58 INFO : sub/yam.rclone_chunk.001_cfu49q: Moved (server-side) to: sub/yam 2025/06/24 02:42:58 DEBUG : sub/yam: md5 = 48dc443644c4b89556dc06834b46451d OK 2025/06/24 02:42:58 INFO : sub/yam: Copied (new) 2025/06/24 02:42:59 INFO : potato.rclone_chunk.001_cfu47s: Moved (server-side) to: potato 2025/06/24 02:42:59 DEBUG : potato: md5 = 7f6fa9ddec9bfebda9510af0323fd696 OK 2025/06/24 02:42:59 INFO : potato: Copied (new) 2025/06/24 02:42:59 DEBUG : Waiting for deletions to finish 2025/06/24 02:43:01 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/24 02:43:01 DEBUG : potato: Unchanged skipping 2025/06/24 02:43:01 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Making map for --track-renames 2025/06/24 02:43:01 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Finished making map for --track-renames 2025/06/24 02:43:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for checks to finish 2025/06/24 02:43:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for renames to finish 2025/06/24 02:43:01 DEBUG : sub/yam: move non-chunked object... 2025/06/24 02:43:03 INFO : sub/yam: Moved (server-side) to: yam 2025/06/24 02:43:03 INFO : sub/yam: Moved (server-side) to: yam 2025/06/24 02:43:03 INFO : yam: Renamed from "sub/yam" 2025/06/24 02:43:03 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for transfers to finish 2025/06/24 02:43:03 DEBUG : Waiting for deletions to finish 2025/06/24 02:43:03 INFO : There was nothing to transfer --- PASS: TestSyncWithTrackRenamesStrategyLeaf (26.13s) === RUN TestSyncCompareDest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu'", Local "Local file system at /tmp/rclone2944403158", Modify Window "1ns" 2025/06/24 02:43:20 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst" 2025/06/24 02:43:20 DEBUG : Creating backend with remote "TestYandex:rclone-test-lacahun1veyu/dst" 2025/06/24 02:43:20 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/CompareDest" 2025/06/24 02:43:20 DEBUG : Creating backend with remote "TestYandex:rclone-test-lacahun1veyu/CompareDest" 2025/06/24 02:43:21 DEBUG : one: Need to transfer - File not found at Destination 2025/06/24 02:43:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for checks to finish 2025/06/24 02:43:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for transfers to finish 2025/06/24 02:43:22 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/06/24 02:43:26 INFO : one.rclone_chunk.001_cfuwlp: Moved (server-side) to: one 2025/06/24 02:43:26 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2025/06/24 02:43:26 INFO : one: Copied (new) 2025/06/24 02:43:26 DEBUG : Waiting for deletions to finish 2025/06/24 02:43:27 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/24 02:43:27 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for checks to finish 2025/06/24 02:43:27 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for transfers to finish 2025/06/24 02:43:27 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/06/24 02:43:36 INFO : one: Deleted 2025/06/24 02:43:37 INFO : one.rclone_chunk.001_cfv1yn: Moved (server-side) to: one 2025/06/24 02:43:37 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/06/24 02:43:37 INFO : one: Copied (replaced existing) 2025/06/24 02:43:37 DEBUG : Waiting for deletions to finish 2025/06/24 02:43:46 INFO : dst/one: Deleted 2025/06/24 02:43:47 INFO : dst/one.rclone_chunk.001_cfvco7: Moved (server-side) to: dst/one 2025/06/24 02:43:51 INFO : CompareDest/one.rclone_chunk.001_cfvm3m: Moved (server-side) to: CompareDest/one 2025/06/24 02:43:52 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/24 02:43:52 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for checks to finish 2025/06/24 02:43:53 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/24 02:43:53 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/24 02:43:53 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for transfers to finish 2025/06/24 02:43:53 DEBUG : Waiting for deletions to finish 2025/06/24 02:43:53 INFO : There was nothing to transfer 2025/06/24 02:43:59 INFO : CompareDest/two.rclone_chunk.001_cfvsnx: Moved (server-side) to: CompareDest/two 2025/06/24 02:44:00 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/24 02:44:01 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/24 02:44:01 DEBUG : two: Destination found in --compare-dest, skipping 2025/06/24 02:44:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for checks to finish 2025/06/24 02:44:01 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/24 02:44:01 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/24 02:44:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for transfers to finish 2025/06/24 02:44:01 DEBUG : Waiting for deletions to finish 2025/06/24 02:44:01 INFO : There was nothing to transfer 2025/06/24 02:44:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/24 02:44:03 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/24 02:44:03 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/24 02:44:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/24 02:44:03 DEBUG : two: Destination found in --compare-dest, skipping 2025/06/24 02:44:03 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for checks to finish 2025/06/24 02:44:03 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for transfers to finish 2025/06/24 02:44:03 DEBUG : Waiting for deletions to finish 2025/06/24 02:44:03 INFO : There was nothing to transfer 2025/06/24 02:44:04 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/24 02:44:05 DEBUG : two: Modification times differ by -119h59m59.876543211s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59.123456789 +0000 UTC 2025/06/24 02:44:05 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2025/06/24 02:44:05 DEBUG : two: Destination found in --compare-dest, skipping 2025/06/24 02:44:05 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for checks to finish 2025/06/24 02:44:05 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/24 02:44:05 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/24 02:44:05 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for transfers to finish 2025/06/24 02:44:05 DEBUG : Waiting for deletions to finish 2025/06/24 02:44:05 INFO : There was nothing to transfer 2025/06/24 02:44:06 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/24 02:44:07 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/24 02:44:07 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/24 02:44:07 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/06/24 02:44:07 DEBUG : two: Need to transfer - File not found at Destination 2025/06/24 02:44:07 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for checks to finish 2025/06/24 02:44:07 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu/dst': Waiting for transfers to finish 2025/06/24 02:44:07 DEBUG : two: skip slow MD5 on source file, hashing in-transit 2025/06/24 02:44:12 INFO : two.rclone_chunk.001_cfw5is: Moved (server-side) to: two 2025/06/24 02:44:12 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK 2025/06/24 02:44:12 INFO : two: Copied (new) 2025/06/24 02:44:12 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCompareDest (82.84s) === RUN TestSyncIgnoreCase run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu'", Local "Local file system at /tmp/rclone2944403158", Modify Window "1ns" 2025/06/24 02:44:48 INFO : EXISTING.rclone_chunk.001_cfx5mm: Moved (server-side) to: EXISTING 2025/06/24 02:44:48 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/24 02:44:48 DEBUG : existing: Unchanged skipping 2025/06/24 02:44:48 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for checks to finish 2025/06/24 02:44:48 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Waiting for transfers to finish 2025/06/24 02:44:48 DEBUG : Waiting for deletions to finish 2025/06/24 02:44:48 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (11.22s) PASS 2025/06/24 02:44:54 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lacahun1veyu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestCopyEmptyDirectories|TestSyncCompareDest|TestSyncIgnoreCase|TestSyncWithTrackRenamesStrategyLeaf)$'" - Finished OK in 2m37.31341463s (try 2/5)