"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestSyncDeleteDuring|TestSyncIgnoreTimes|TestSyncSuffix)$'" - Starting (try 2/5) 2025/04/14 03:21:17 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-yakupar5cane" 2025/04/14 03:21:17 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/14 03:21:17 DEBUG : Creating backend with remote "TestYandex:rclone-test-yakupar5cane" 2025/04/14 03:21:17 DEBUG : Creating backend with remote "/tmp/rclone3229078440" === RUN TestSyncIgnoreTimes run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane'", Local "Local file system at /tmp/rclone3229078440", Modify Window "1ns" 2025/04/14 03:21:24 INFO : existing.rclone_chunk.001_p09cg6: Moved (server-side) to: existing 2025/04/14 03:21:25 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/14 03:21:25 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane': Waiting for checks to finish 2025/04/14 03:21:25 DEBUG : existing: Unchanged skipping 2025/04/14 03:21:25 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane': Waiting for transfers to finish 2025/04/14 03:21:25 DEBUG : Waiting for deletions to finish 2025/04/14 03:21:25 INFO : There was nothing to transfer run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane'", Local "Local file system at /tmp/rclone3229078440", Modify Window "1ns" 2025/04/14 03:21:26 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2025/04/14 03:21:26 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane': Waiting for checks to finish 2025/04/14 03:21:26 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane': Waiting for transfers to finish 2025/04/14 03:21:26 DEBUG : existing: skip slow MD5 on source file, hashing in-transit 2025/04/14 03:21:34 INFO : existing: Deleted 2025/04/14 03:21:37 INFO : existing.rclone_chunk.001_p09k3t: Moved (server-side) to: existing 2025/04/14 03:21:37 DEBUG : existing: md5 = 8ee2027983915ec78acc45027d874316 OK 2025/04/14 03:21:37 INFO : existing: Copied (replaced existing) 2025/04/14 03:21:37 DEBUG : Waiting for deletions to finish run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane'", Local "Local file system at /tmp/rclone3229078440", Modify Window "1ns" --- PASS: TestSyncIgnoreTimes (26.60s) === RUN TestSyncDeleteDuring run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane'", Local "Local file system at /tmp/rclone3229078440", Modify Window "1ns" 2025/04/14 03:21:49 INFO : potato.rclone_chunk.001_p0a2hm: Moved (server-side) to: potato 2025/04/14 03:21:55 INFO : empty space.rclone_chunk.001_p0a7kv: Moved (server-side) to: empty space 2025/04/14 03:21:55 DEBUG : Waiting for deletions to finish 2025/04/14 03:21:56 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/14 03:21:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/04/14 03:21:56 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane': Waiting for checks to finish 2025/04/14 03:21:56 DEBUG : empty space: Unchanged skipping 2025/04/14 03:21:56 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane': Waiting for transfers to finish 2025/04/14 03:21:56 DEBUG : potato2: skip slow MD5 on source file, hashing in-transit 2025/04/14 03:22:00 INFO : potato: Deleted 2025/04/14 03:22:00 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2025/04/14 03:22:00 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/04/14 03:22:01 DEBUG : pacer: Reducing sleep to 15ms 2025/04/14 03:22:01 DEBUG : pacer: Reducing sleep to 11.25ms 2025/04/14 03:22:01 DEBUG : pacer: Reducing sleep to 10ms 2025/04/14 03:22:03 INFO : potato2.rclone_chunk.001_p0aedu: Moved (server-side) to: potato2.rclone_chunk.001 2025/04/14 03:22:04 INFO : potato2.rclone_chunk.002_p0aedu: Moved (server-side) to: potato2.rclone_chunk.002 2025/04/14 03:22:07 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK 2025/04/14 03:22:07 INFO : potato2: Copied (new) run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane'", Local "Local file system at /tmp/rclone3229078440", Modify Window "1ns" --- PASS: TestSyncDeleteDuring (42.64s) === RUN TestSyncSuffix run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane'", Local "Local file system at /tmp/rclone3229078440", Modify Window "1ns" 2025/04/14 03:22:33 INFO : dst/one.rclone_chunk.001_p0b9gk: Moved (server-side) to: dst/one 2025/04/14 03:22:42 INFO : dst/two.rclone_chunk.001_p0bfqc: Moved (server-side) to: dst/two 2025/04/14 03:22:47 INFO : dst/three.txt.rclone_chunk.001_p0bojk: Moved (server-side) to: dst/three.txt 2025/04/14 03:22:48 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-yakupar5cane/dst" 2025/04/14 03:22:48 DEBUG : Config file has changed externally - reloading 2025/04/14 03:22:48 DEBUG : Creating backend with remote "TestYandex:rclone-test-yakupar5cane/dst" 2025/04/14 03:22:49 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/04/14 03:22:50 DEBUG : one: move non-chunked object... 2025/04/14 03:22:54 INFO : one: Moved (server-side) to: one.bak 2025/04/14 03:22:54 INFO : one: Moved (server-side) to: one.bak 2025/04/14 03:22:54 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/04/14 03:22:59 INFO : one.rclone_chunk.001_p0c0nq: Moved (server-side) to: one 2025/04/14 03:22:59 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/04/14 03:22:59 INFO : one: Copied (new) 2025/04/14 03:23:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/14 03:23:00 DEBUG : two: Unchanged skipping 2025/04/14 03:23:01 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/04/14 03:23:03 DEBUG : three.txt: move non-chunked object... 2025/04/14 03:23:05 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/14 03:23:05 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/14 03:23:05 DEBUG : three.txt: skip slow MD5 on source file, hashing in-transit 2025/04/14 03:23:11 INFO : three.txt.rclone_chunk.001_p0cby9: Moved (server-side) to: three.txt 2025/04/14 03:23:11 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2025/04/14 03:23:11 INFO : three.txt: Copied (new) 2025/04/14 03:23:14 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/04/14 03:23:19 INFO : one.bak: Deleted 2025/04/14 03:23:19 DEBUG : one: move non-chunked object... 2025/04/14 03:23:20 INFO : one: Moved (server-side) to: one.bak 2025/04/14 03:23:20 INFO : one: Moved (server-side) to: one.bak 2025/04/14 03:23:21 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/04/14 03:23:26 INFO : one.rclone_chunk.001_p0cr4j: Moved (server-side) to: one 2025/04/14 03:23:26 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/04/14 03:23:26 INFO : one: Copied (new) 2025/04/14 03:23:27 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/04/14 03:23:27 DEBUG : two: Unchanged skipping 2025/04/14 03:23:27 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/04/14 03:23:32 INFO : three.txt.bak: Deleted 2025/04/14 03:23:32 DEBUG : three.txt: move non-chunked object... 2025/04/14 03:23:35 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/14 03:23:35 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/04/14 03:23:35 DEBUG : three.txt: skip slow MD5 on source file, hashing in-transit 2025/04/14 03:23:41 INFO : three.txt.rclone_chunk.001_p0d5jr: Moved (server-side) to: three.txt 2025/04/14 03:23:41 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2025/04/14 03:23:41 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (102.87s) PASS 2025/04/14 03:24:09 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-yakupar5cane': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestSyncDeleteDuring|TestSyncIgnoreTimes|TestSyncSuffix)$'" - Finished OK in 2m56.823118597s (try 2/5)