"./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestSyncCompareDest|TestSyncDoesntUpdateModtime)$'" - Starting (try 2/5)
2025/11/04 03:05:45 DEBUG : Creating backend with remote "TestYandex:rclone-test-gokeroh2tuhe"
2025/11/04 03:05:45 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/11/04 03:05:45 DEBUG : Creating backend with remote "/tmp/rclone2581908978"
=== RUN   TestSyncDoesntUpdateModtime
    run.go:185: Remote "Yandex rclone-test-gokeroh2tuhe", Local "Local file system at /tmp/rclone2581908978", Modify Window "1ns"
2025/11/04 03:05:48 DEBUG : foo: size = 3 OK
2025/11/04 03:05:48 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/11/04 03:05:48 DEBUG : Yandex rclone-test-gokeroh2tuhe: Waiting for checks to finish
2025/11/04 03:05:48 DEBUG : foo: md5 = acbd18db4cc2f85cedef654fccc4a4d8 (Local file system at /tmp/rclone2581908978)
2025/11/04 03:05:48 DEBUG : foo: md5 = 37b51d194a7513e45b56f6524f2d51f2 (Yandex rclone-test-gokeroh2tuhe)
2025/11/04 03:05:48 DEBUG : foo: md5 differ
2025/11/04 03:05:48 DEBUG : Yandex rclone-test-gokeroh2tuhe: Waiting for transfers to finish
2025/11/04 03:05:52 DEBUG : foo: size = 3 OK
2025/11/04 03:05:52 DEBUG : foo: Dst hash empty - aborting Src hash check
2025/11/04 03:05:52 INFO  : foo: Copied (replaced existing)
2025/11/04 03:05:52 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncDoesntUpdateModtime (14.11s)
=== RUN   TestSyncCompareDest
    run.go:185: Remote "Yandex rclone-test-gokeroh2tuhe", Local "Local file system at /tmp/rclone2581908978", Modify Window "1ns"
2025/11/04 03:05:59 DEBUG : Creating backend with remote "TestYandex:rclone-test-gokeroh2tuhe/dst"
2025/11/04 03:06:00 DEBUG : Creating backend with remote "TestYandex:rclone-test-gokeroh2tuhe/CompareDest"
2025/11/04 03:06:00 DEBUG : one: Need to transfer - File not found at Destination
2025/11/04 03:06:00 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for checks to finish
2025/11/04 03:06:00 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for transfers to finish
2025/11/04 03:06:02 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2025/11/04 03:06:02 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/11/04 03:06:03 DEBUG : pacer: Reducing sleep to 15ms
2025/11/04 03:06:03 DEBUG : pacer: Reducing sleep to 11.25ms
2025/11/04 03:06:03 DEBUG : one: size = 3 OK
2025/11/04 03:06:03 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2025/11/04 03:06:03 INFO  : one: Copied (new)
2025/11/04 03:06:03 DEBUG : Waiting for deletions to finish
2025/11/04 03:06:05 DEBUG : pacer: Reducing sleep to 10ms
2025/11/04 03:06:05 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for checks to finish
2025/11/04 03:06:05 DEBUG : one: size = 5 (Local file system at /tmp/rclone2581908978)
2025/11/04 03:06:05 DEBUG : one: size = 3 (Yandex rclone-test-gokeroh2tuhe/dst)
2025/11/04 03:06:05 DEBUG : one: Sizes differ
2025/11/04 03:06:06 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for transfers to finish
2025/11/04 03:06:08 DEBUG : one: size = 5 OK
2025/11/04 03:06:08 DEBUG : one: Dst hash empty - aborting Src hash check
2025/11/04 03:06:08 INFO  : one: Copied (replaced existing)
2025/11/04 03:06:08 DEBUG : Waiting for deletions to finish
2025/11/04 03:06:14 DEBUG : one: size = 5 (Local file system at /tmp/rclone2581908978)
2025/11/04 03:06:14 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for checks to finish
2025/11/04 03:06:14 DEBUG : one: size = 3 (Yandex rclone-test-gokeroh2tuhe/dst)
2025/11/04 03:06:14 DEBUG : one: Sizes differ
2025/11/04 03:06:15 DEBUG : one: size = 5 OK
2025/11/04 03:06:15 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/11/04 03:06:15 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/04 03:06:15 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for transfers to finish
2025/11/04 03:06:15 DEBUG : Waiting for deletions to finish
2025/11/04 03:06:15 INFO  : There was nothing to transfer
2025/11/04 03:06:18 DEBUG : one: size = 5 (Local file system at /tmp/rclone2581908978)
2025/11/04 03:06:18 DEBUG : one: size = 3 (Yandex rclone-test-gokeroh2tuhe/dst)
2025/11/04 03:06:18 DEBUG : one: Sizes differ
2025/11/04 03:06:19 DEBUG : two: size = 3 OK
2025/11/04 03:06:19 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/11/04 03:06:19 DEBUG : two: Destination found in --compare-dest, skipping
2025/11/04 03:06:19 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for checks to finish
2025/11/04 03:06:19 DEBUG : one: size = 5 OK
2025/11/04 03:06:19 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/11/04 03:06:19 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/04 03:06:19 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for transfers to finish
2025/11/04 03:06:19 DEBUG : Waiting for deletions to finish
2025/11/04 03:06:19 INFO  : There was nothing to transfer
2025/11/04 03:06:20 DEBUG : one: size = 5 (Local file system at /tmp/rclone2581908978)
2025/11/04 03:06:20 DEBUG : one: size = 3 (Yandex rclone-test-gokeroh2tuhe/dst)
2025/11/04 03:06:20 DEBUG : one: Sizes differ
2025/11/04 03:06:20 DEBUG : two: size = 3 OK
2025/11/04 03:06:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/11/04 03:06:20 DEBUG : two: Destination found in --compare-dest, skipping
2025/11/04 03:06:20 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for checks to finish
2025/11/04 03:06:20 DEBUG : one: size = 5 OK
2025/11/04 03:06:20 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/11/04 03:06:20 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/04 03:06:20 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for transfers to finish
2025/11/04 03:06:20 DEBUG : Waiting for deletions to finish
2025/11/04 03:06:20 INFO  : There was nothing to transfer
2025/11/04 03:06:21 DEBUG : one: size = 5 (Local file system at /tmp/rclone2581908978)
2025/11/04 03:06:21 DEBUG : one: size = 3 (Yandex rclone-test-gokeroh2tuhe/dst)
2025/11/04 03:06:21 DEBUG : one: Sizes differ
2025/11/04 03:06:21 DEBUG : two: size = 3 OK
2025/11/04 03:06:21 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/11/04 03:06:21 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2025/11/04 03:06:21 DEBUG : two: Destination found in --compare-dest, skipping
2025/11/04 03:06:21 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for checks to finish
2025/11/04 03:06:22 DEBUG : one: size = 5 OK
2025/11/04 03:06:22 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/11/04 03:06:22 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/04 03:06:22 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for transfers to finish
2025/11/04 03:06:22 DEBUG : Waiting for deletions to finish
2025/11/04 03:06:22 INFO  : There was nothing to transfer
2025/11/04 03:06:24 DEBUG : one: size = 5 (Local file system at /tmp/rclone2581908978)
2025/11/04 03:06:24 DEBUG : one: size = 3 (Yandex rclone-test-gokeroh2tuhe/dst)
2025/11/04 03:06:24 DEBUG : one: Sizes differ
2025/11/04 03:06:24 DEBUG : one: size = 5 OK
2025/11/04 03:06:24 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/11/04 03:06:24 DEBUG : one: Destination found in --compare-dest, skipping
2025/11/04 03:06:24 DEBUG : two: size = 5 (Local file system at /tmp/rclone2581908978)
2025/11/04 03:06:24 DEBUG : two: size = 3 (Yandex rclone-test-gokeroh2tuhe/CompareDest)
2025/11/04 03:06:24 DEBUG : two: Sizes differ
2025/11/04 03:06:24 DEBUG : two: Need to transfer - File not found at Destination
2025/11/04 03:06:24 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for checks to finish
2025/11/04 03:06:24 DEBUG : Yandex rclone-test-gokeroh2tuhe/dst: Waiting for transfers to finish
2025/11/04 03:06:26 DEBUG : two: size = 5 OK
2025/11/04 03:06:26 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK
2025/11/04 03:06:26 INFO  : two: Copied (new)
2025/11/04 03:06:26 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCompareDest (61.85s)
PASS
2025/11/04 03:07:01 DEBUG : Yandex rclone-test-gokeroh2tuhe: Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestSyncCompareDest|TestSyncDoesntUpdateModtime)$'" - Finished OK in 1m21.668303602s (try 2/5)