"./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestCheckSum|TestCheckSumDownload|TestDeduplicateNewestByHash)$|^TestStatJSON$/^(File|FileFilesOnly)$'" - Starting (try 2/5)
2025/05/05 02:29:28 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-doniruc8puhu"
2025/05/05 02:29:28 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/05 02:29:28 DEBUG : Creating backend with remote "TestYandex:rclone-test-doniruc8puhu"
2025/05/05 02:29:28 DEBUG : Creating backend with remote "/tmp/rclone115751149"
=== RUN   TestCheckSum
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-doniruc8puhu'", Local "Local file system at /tmp/rclone115751149", Modify Window "1ns"
2025/05/05 02:29:28 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-doniruc8puhu/data"
2025/05/05 02:29:28 DEBUG : Creating backend with remote "TestYandex:rclone-test-doniruc8puhu/data"
2025/05/05 02:29:35 INFO  : data/banana.rclone_chunk.001_rtv6nx: Moved (server-side) to: data/banana
2025/05/05 02:29:40 INFO  : test.sum.rclone_chunk.001_rtvc2e: Moved (server-side) to: test.sum
=== RUN   TestCheckSum/subtest1
2025/05/05 02:29:47 INFO  : data/potato.rclone_chunk.001_rtvjod: Moved (server-side) to: data/potato
2025/05/05 02:29:56 INFO  : test.sum: Deleted
2025/05/05 02:29:57 INFO  : test.sum.rclone_chunk.001_rtvor1: Moved (server-side) to: test.sum
=== RUN   TestCheckSum/subtest2
2025/05/05 02:30:07 INFO  : test.sum.rclone_chunk.001_rtw2a2: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:30:09 INFO  : test.sum.rclone_chunk.002_rtw2a2: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSum/subtest3
2025/05/05 02:30:33 INFO  : test.sum.rclone_chunk.001_rtwioa: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:30:35 INFO  : test.sum.rclone_chunk.002_rtwioa: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSum/subtest4
2025/05/05 02:31:01 INFO  : test.sum.rclone_chunk.001_rtx711: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:31:03 INFO  : test.sum.rclone_chunk.002_rtx711: Moved (server-side) to: test.sum.rclone_chunk.002
2025/05/05 02:31:04 INFO  : test.sum.rclone_chunk.003_rtx711: Moved (server-side) to: test.sum.rclone_chunk.003
=== RUN   TestCheckSum/subtest5
2025/05/05 02:31:39 INFO  : test.sum.rclone_chunk.001_rty431: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:31:41 INFO  : test.sum.rclone_chunk.002_rty431: Moved (server-side) to: test.sum.rclone_chunk.002
2025/05/05 02:31:42 INFO  : test.sum.rclone_chunk.003_rty431: Moved (server-side) to: test.sum.rclone_chunk.003
2025/05/05 02:31:44 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2025/05/05 02:31:44 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/05/05 02:31:45 DEBUG : pacer: Reducing sleep to 15ms
2025/05/05 02:31:45 DEBUG : pacer: Reducing sleep to 11.25ms
2025/05/05 02:31:45 DEBUG : pacer: Reducing sleep to 10ms
=== RUN   TestCheckSum/subtest6
2025/05/05 02:31:59 INFO  : data/banana: Deleted
2025/05/05 02:32:01 INFO  : data/banana.rclone_chunk.001_rtz3xw: Moved (server-side) to: data/banana
2025/05/05 02:32:09 INFO  : data/potato: Deleted
2025/05/05 02:32:10 INFO  : data/potato.rclone_chunk.001_rtzfwj: Moved (server-side) to: data/potato
2025/05/05 02:32:34 INFO  : test.sum.rclone_chunk.001_rtzpz3: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:32:35 INFO  : test.sum.rclone_chunk.002_rtzpz3: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSum/subtest7
--- PASS: TestCheckSum (222.45s)
    --- PASS: TestCheckSum/subtest1 (1.55s)
    --- PASS: TestCheckSum/subtest2 (1.79s)
    --- PASS: TestCheckSum/subtest3 (2.54s)
    --- PASS: TestCheckSum/subtest4 (2.64s)
    --- PASS: TestCheckSum/subtest5 (2.96s)
    --- PASS: TestCheckSum/subtest6 (3.25s)
    --- PASS: TestCheckSum/subtest7 (3.21s)
=== RUN   TestCheckSumDownload
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-doniruc8puhu'", Local "Local file system at /tmp/rclone115751149", Modify Window "1ns"
2025/05/05 02:33:11 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-doniruc8puhu/data"
2025/05/05 02:33:11 DEBUG : Creating backend with remote "TestYandex:rclone-test-doniruc8puhu/data"
2025/05/05 02:33:16 INFO  : data/banana.rclone_chunk.001_ru1doh: Moved (server-side) to: data/banana
2025/05/05 02:33:21 INFO  : test.sum.rclone_chunk.001_ru1hcc: Moved (server-side) to: test.sum
=== RUN   TestCheckSumDownload/subtest1
2025/05/05 02:33:29 INFO  : data/potato.rclone_chunk.001_ru1pvx: Moved (server-side) to: data/potato
2025/05/05 02:33:38 INFO  : test.sum: Deleted
2025/05/05 02:33:39 INFO  : test.sum.rclone_chunk.001_ru1vbj: Moved (server-side) to: test.sum
=== RUN   TestCheckSumDownload/subtest2
2025/05/05 02:33:49 INFO  : test.sum.rclone_chunk.001_ru27r3: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:33:51 INFO  : test.sum.rclone_chunk.002_ru27r3: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSumDownload/subtest3
2025/05/05 02:34:14 INFO  : test.sum.rclone_chunk.001_ru2ng2: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:34:16 INFO  : test.sum.rclone_chunk.002_ru2ng2: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSumDownload/subtest4
2025/05/05 02:34:42 INFO  : test.sum.rclone_chunk.001_ru3e3u: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:34:43 INFO  : test.sum.rclone_chunk.002_ru3e3u: Moved (server-side) to: test.sum.rclone_chunk.002
2025/05/05 02:34:45 INFO  : test.sum.rclone_chunk.003_ru3e3u: Moved (server-side) to: test.sum.rclone_chunk.003
=== RUN   TestCheckSumDownload/subtest5
2025/05/05 02:35:15 INFO  : test.sum.rclone_chunk.001_ru46ls: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:35:16 INFO  : test.sum.rclone_chunk.002_ru46ls: Moved (server-side) to: test.sum.rclone_chunk.002
2025/05/05 02:35:18 INFO  : test.sum.rclone_chunk.003_ru46ls: Moved (server-side) to: test.sum.rclone_chunk.003
=== RUN   TestCheckSumDownload/subtest6
2025/05/05 02:36:33 INFO  : data/banana: Deleted
2025/05/05 02:36:34 INFO  : data/banana.rclone_chunk.001_ru53f5: Moved (server-side) to: data/banana
2025/05/05 02:36:42 INFO  : data/potato: Deleted
2025/05/05 02:36:44 INFO  : data/potato.rclone_chunk.001_ru701i: Moved (server-side) to: data/potato
2025/05/05 02:37:16 INFO  : test.sum.rclone_chunk.001_ru7ame: Moved (server-side) to: test.sum.rclone_chunk.001
2025/05/05 02:37:18 INFO  : test.sum.rclone_chunk.002_ru7ame: Moved (server-side) to: test.sum.rclone_chunk.002
=== RUN   TestCheckSumDownload/subtest7
--- PASS: TestCheckSumDownload (283.56s)
    --- PASS: TestCheckSumDownload/subtest1 (2.44s)
    --- PASS: TestCheckSumDownload/subtest2 (1.79s)
    --- PASS: TestCheckSumDownload/subtest3 (2.69s)
    --- PASS: TestCheckSumDownload/subtest4 (2.51s)
    --- PASS: TestCheckSumDownload/subtest5 (3.82s)
    --- PASS: TestCheckSumDownload/subtest6 (3.85s)
    --- PASS: TestCheckSumDownload/subtest7 (2.95s)
=== RUN   TestDeduplicateNewestByHash
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-doniruc8puhu'", Local "Local file system at /tmp/rclone115751149", Modify Window "1ns"
2025/05/05 02:38:00 INFO  : one.rclone_chunk.001_ru98tz: Moved (server-side) to: one.rclone_chunk.001
2025/05/05 02:38:02 INFO  : one.rclone_chunk.002_ru98tz: Moved (server-side) to: one.rclone_chunk.002
2025/05/05 02:38:12 INFO  : also/one.rclone_chunk.001_ru9ig5: Moved (server-side) to: also/one.rclone_chunk.001
2025/05/05 02:38:13 INFO  : also/one.rclone_chunk.002_ru9ig5: Moved (server-side) to: also/one.rclone_chunk.002
2025/05/05 02:38:22 INFO  : another.rclone_chunk.001_ru9tlg: Moved (server-side) to: another.rclone_chunk.001
2025/05/05 02:38:23 INFO  : another.rclone_chunk.002_ru9tlg: Moved (server-side) to: another.rclone_chunk.002
2025/05/05 02:38:31 INFO  : not-one.rclone_chunk.001_rua3yz: Moved (server-side) to: not-one
2025/05/05 02:38:35 INFO  : Chunked 'TestChunkerChunk50bYandex:rclone-test-doniruc8puhu': Looking for duplicate md5 hashes using newest mode.
2025/05/05 02:38:37 NOTICE: 4ce763a85f1db747cfedcd23d446fa96: Found 3 files with duplicate md5 hashes
2025/05/05 02:38:50 INFO  : one: Deleted
2025/05/05 02:39:03 INFO  : also/one: Deleted
2025/05/05 02:39:03 NOTICE: 4ce763a85f1db747cfedcd23d446fa96: Deleted 2 extra copies
--- PASS: TestDeduplicateNewestByHash (99.35s)
=== RUN   TestStatJSON
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-doniruc8puhu'", Local "Local file system at /tmp/rclone115751149", Modify Window "1ns"
2025/05/05 02:39:40 INFO  : file1.rclone_chunk.001_rubz95: Moved (server-side) to: file1
2025/05/05 02:39:45 INFO  : sub/file2.rclone_chunk.001_ruc5ih: Moved (server-side) to: sub/file2
=== RUN   TestStatJSON/File
=== RUN   TestStatJSON/FileFilesOnly
--- PASS: TestStatJSON (30.54s)
    --- PASS: TestStatJSON/File (0.69s)
    --- PASS: TestStatJSON/FileFilesOnly (0.65s)
PASS
2025/05/05 02:40:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-doniruc8puhu': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestCheckSum|TestCheckSumDownload|TestDeduplicateNewestByHash)$|^TestStatJSON$/^(File|FileFilesOnly)$'" - Finished OK in 10m42.591493798s (try 2/5)