"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestMoveOverSelf|TestNothingToTransferWithEmptyDirs|TestSyncBackupDirWithSuffixKeepExtension|TestSyncMultipleCompareDest|TestSyncNoTraverse)$'" - Starting (try 2/5)
2024/11/12 01:55:43 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo"
2024/11/12 01:55:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/12 01:55:43 DEBUG : Creating backend with remote "TestYandex:rclone-test-gapoyaf1keqo"
2024/11/12 01:55:43 DEBUG : Reset feature "ListR"
2024/11/12 01:55:43 DEBUG : Creating backend with remote "/tmp/rclone2880192084"
=== RUN   TestSyncNoTraverse
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo'", Local "Local file system at /tmp/rclone2880192084", Modify Window "1ns"
2024/11/12 01:55:43 ERROR : Ignoring --no-traverse with sync
2024/11/12 01:55:43 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/12 01:55:43 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo': Waiting for checks to finish
2024/11/12 01:55:43 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo': Waiting for transfers to finish
2024/11/12 01:55:44 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2024/11/12 01:55:49 INFO  : sub dir/hello world.rclone_chunk.001_tk9680: Moved (server-side) to: sub dir/hello world
2024/11/12 01:55:49 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2024/11/12 01:55:49 INFO  : sub dir/hello world: Copied (new)
2024/11/12 01:55:49 DEBUG : Waiting for deletions to finish
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo'", Local "Local file system at /tmp/rclone2880192084", Modify Window "1ns"
--- PASS: TestSyncNoTraverse (13.31s)
=== RUN   TestMoveOverSelf
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo'", Local "Local file system at /tmp/rclone2880192084", Modify Window "1ns"
2024/11/12 01:55:59 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2024/11/12 01:55:59 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2024/11/12 01:56:00 DEBUG : pacer: Reducing sleep to 15ms
2024/11/12 01:56:00 DEBUG : pacer: Reducing sleep to 11.25ms
2024/11/12 01:56:01 DEBUG : pacer: Reducing sleep to 10ms
2024/11/12 01:56:03 INFO  : sub dir/hello world.rclone_chunk.001_tk9jap: Moved (server-side) to: sub dir/hello world
2024/11/12 01:56:05 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2024/11/12 01:56:05 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo': Waiting for checks to finish
2024/11/12 01:56:05 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo': Waiting for transfers to finish
2024/11/12 01:56:05 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2024/11/12 01:56:11 INFO  : sub dir/hello world: Deleted
2024/11/12 01:56:12 INFO  : sub dir/hello world.rclone_chunk.001_tk9r4s: Moved (server-side) to: sub dir/hello world
2024/11/12 01:56:12 DEBUG : sub dir/hello world: md5 = 00321a507bdb420dbbd4f53c733b1505 OK
2024/11/12 01:56:12 INFO  : sub dir/hello world: Copied (replaced existing)
2024/11/12 01:56:12 INFO  : sub dir/hello world: Deleted
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo'", Local "Local file system at /tmp/rclone2880192084", Modify Window "1ns"
--- PASS: TestMoveOverSelf (22.12s)
=== RUN   TestSyncMultipleCompareDest
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo'", Local "Local file system at /tmp/rclone2880192084", Modify Window "1ns"
2024/11/12 01:56:24 INFO  : pre-dest1/1.rclone_chunk.001_tka5jv: Moved (server-side) to: pre-dest1/1
2024/11/12 01:56:30 INFO  : pre-dest2/2.rclone_chunk.001_tkaagq: Moved (server-side) to: pre-dest2/2
2024/11/12 01:56:31 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/dest"
2024/11/12 01:56:31 DEBUG : Creating backend with remote "TestYandex:rclone-test-gapoyaf1keqo/dest"
2024/11/12 01:56:31 DEBUG : Reset feature "ListR"
2024/11/12 01:56:31 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/pre-dest1"
2024/11/12 01:56:31 DEBUG : Creating backend with remote "TestYandex:rclone-test-gapoyaf1keqo/pre-dest1"
2024/11/12 01:56:32 DEBUG : Reset feature "ListR"
2024/11/12 01:56:32 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/pre-dest2"
2024/11/12 01:56:32 DEBUG : Creating backend with remote "TestYandex:rclone-test-gapoyaf1keqo/pre-dest2"
2024/11/12 01:56:32 DEBUG : Reset feature "ListR"
2024/11/12 01:56:33 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/11/12 01:56:33 DEBUG : 1: Destination found in --compare-dest, skipping
2024/11/12 01:56:34 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/11/12 01:56:34 DEBUG : 2: Destination found in --compare-dest, skipping
2024/11/12 01:56:35 DEBUG : 3: Need to transfer - File not found at Destination
2024/11/12 01:56:35 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/dest': Waiting for checks to finish
2024/11/12 01:56:35 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/dest': Waiting for transfers to finish
2024/11/12 01:56:35 DEBUG : 3: skip slow MD5 on source file, hashing in-transit
2024/11/12 01:56:39 INFO  : 3.rclone_chunk.001_tkalzx: Moved (server-side) to: 3
2024/11/12 01:56:39 DEBUG : 3: md5 = eccbc87e4b5ce2fe28308fd9f2a7baf3 OK
2024/11/12 01:56:39 INFO  : 3: Copied (new)
2024/11/12 01:56:39 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncMultipleCompareDest (33.58s)
=== RUN   TestSyncBackupDirWithSuffixKeepExtension
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo'", Local "Local file system at /tmp/rclone2880192084", Modify Window "1ns"
2024/11/12 01:56:58 INFO  : dst/one.rclone_chunk.001_tkb29u: Moved (server-side) to: dst/one
2024/11/12 01:57:03 INFO  : dst/two.rclone_chunk.001_tkb8em: Moved (server-side) to: dst/two
2024/11/12 01:57:08 INFO  : dst/three.txt.rclone_chunk.001_tkbd6w: Moved (server-side) to: dst/three.txt
2024/11/12 01:57:09 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/dst"
2024/11/12 01:57:09 DEBUG : Creating backend with remote "TestYandex:rclone-test-gapoyaf1keqo/dst"
2024/11/12 01:57:10 DEBUG : Reset feature "ListR"
2024/11/12 01:57:10 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/backup"
2024/11/12 01:57:10 DEBUG : Creating backend with remote "TestYandex:rclone-test-gapoyaf1keqo/backup"
2024/11/12 01:57:10 DEBUG : Reset feature "ListR"
2024/11/12 01:57:10 DEBUG : one: Sizes differ (src 4 vs dst 3)
2024/11/12 01:57:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/11/12 01:57:10 DEBUG : two: Unchanged skipping
2024/11/12 01:57:10 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/dst': Waiting for checks to finish
2024/11/12 01:57:10 DEBUG : one: move non-chunked object...
2024/11/12 01:57:13 INFO  : one: Moved (server-side) to: one-2019-01-01
2024/11/12 01:57:13 INFO  : one: Moved (server-side) to: one-2019-01-01
2024/11/12 01:57:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/dst': Waiting for transfers to finish
2024/11/12 01:57:13 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2024/11/12 01:57:19 INFO  : one.rclone_chunk.001_tkbnwl: Moved (server-side) to: one
2024/11/12 01:57:19 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2024/11/12 01:57:19 INFO  : one: Copied (new)
2024/11/12 01:57:19 DEBUG : Waiting for deletions to finish
2024/11/12 01:57:19 DEBUG : three.txt: move non-chunked object...
2024/11/12 01:57:21 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2024/11/12 01:57:21 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2024/11/12 01:57:21 INFO  : three.txt: Moved into backup dir
2024/11/12 01:57:27 INFO  : dst/three.txt.rclone_chunk.001_tkbwvq: Moved (server-side) to: dst/three.txt
2024/11/12 01:57:29 DEBUG : one: Sizes differ (src 5 vs dst 4)
2024/11/12 01:57:29 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/11/12 01:57:29 DEBUG : two: Unchanged skipping
2024/11/12 01:57:29 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/dst': Waiting for checks to finish
2024/11/12 01:57:31 INFO  : one-2019-01-01: Deleted
2024/11/12 01:57:31 DEBUG : one: move non-chunked object...
2024/11/12 01:57:32 INFO  : one: Moved (server-side) to: one-2019-01-01
2024/11/12 01:57:32 INFO  : one: Moved (server-side) to: one-2019-01-01
2024/11/12 01:57:32 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo/dst': Waiting for transfers to finish
2024/11/12 01:57:32 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2024/11/12 01:57:37 INFO  : one.rclone_chunk.001_tkc6uv: Moved (server-side) to: one
2024/11/12 01:57:37 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2024/11/12 01:57:37 INFO  : one: Copied (new)
2024/11/12 01:57:37 DEBUG : Waiting for deletions to finish
2024/11/12 01:57:39 INFO  : three-2019-01-01.txt: Deleted
2024/11/12 01:57:39 DEBUG : three.txt: move non-chunked object...
2024/11/12 01:57:41 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2024/11/12 01:57:41 INFO  : three.txt: Moved (server-side) to: three-2019-01-01.txt
2024/11/12 01:57:41 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffixKeepExtension (61.01s)
=== RUN   TestNothingToTransferWithEmptyDirs
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo'", Local "Local file system at /tmp/rclone2880192084", Modify Window "1ns"
2024/11/12 01:57:53 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2024/11/12 01:57:53 DEBUG : sub dir: Making directory
2024/11/12 01:57:54 INFO  : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo'", Local "Local file system at /tmp/rclone2880192084", Modify Window "1ns"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo'", Local "Local file system at /tmp/rclone2880192084", Modify Window "1ns"
--- PASS: TestNothingToTransferWithEmptyDirs (61.37s)
PASS
2024/11/12 01:58:55 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-gapoyaf1keqo': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestMoveOverSelf|TestNothingToTransferWithEmptyDirs|TestSyncBackupDirWithSuffixKeepExtension|TestSyncMultipleCompareDest|TestSyncNoTraverse)$'" - Finished OK in 3m13.849662739s (try 2/5)