"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestCopyDeleteBefore|TestCopyOverSelf|TestServerSideMoveOverSelf|TestSyncBackupDirWithSuffix|TestSyncCopyDest|TestSyncDeleteBefore|TestSyncMultipleCompareDest|TestSyncNoEmptyDirectories)$'" - Starting (try 2/5)
2025/01/12 04:08:36 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-meromak7fuki"
2025/01/12 04:08:36 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/12 04:08:36 DEBUG : Creating backend with remote "TestYandex:rclone-test-meromak7fuki"
2025/01/12 04:08:36 DEBUG : Reset feature "ListR"
2025/01/12 04:08:36 DEBUG : Creating backend with remote "/tmp/rclone2891347835"
=== RUN   TestSyncNoEmptyDirectories
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:08:36 INFO  : sub dir2: Making directory
2025/01/12 04:08:37 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/12 04:08:37 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for checks to finish
2025/01/12 04:08:37 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for transfers to finish
2025/01/12 04:08:38 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:08:46 INFO  : sub dir/hello world.rclone_chunk.001_yp39q8: Moved (server-side) to: sub dir/hello world
2025/01/12 04:08:46 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/01/12 04:08:46 INFO  : sub dir/hello world: Copied (new)
2025/01/12 04:08:46 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoEmptyDirectories (20.88s)
=== RUN   TestCopyOverSelf
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:09:05 INFO  : sub dir/hello world.rclone_chunk.001_yp3tud: Moved (server-side) to: sub dir/hello world
2025/01/12 04:09:07 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/01/12 04:09:07 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for checks to finish
2025/01/12 04:09:07 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for transfers to finish
2025/01/12 04:09:07 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:09:21 INFO  : sub dir/hello world: Deleted
2025/01/12 04:09:22 INFO  : sub dir/hello world.rclone_chunk.001_yp42ab: Moved (server-side) to: sub dir/hello world
2025/01/12 04:09:22 DEBUG : sub dir/hello world: md5 = 00321a507bdb420dbbd4f53c733b1505 OK
2025/01/12 04:09:22 INFO  : sub dir/hello world: Copied (replaced existing)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
--- PASS: TestCopyOverSelf (38.15s)
=== RUN   TestServerSideMoveOverSelf
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:09:41 INFO  : sub dir/hello world.rclone_chunk.001_yp4vrp: Moved (server-side) to: sub dir/hello world
2025/01/12 04:09:42 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zubutax2joli"
2025/01/12 04:09:42 DEBUG : Creating backend with remote "TestYandex:rclone-test-zubutax2joli"
2025/01/12 04:09:43 DEBUG : Reset feature "ListR"
    sync_test.go:671: Server side copy (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli'
2025/01/12 04:09:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/12 04:09:44 DEBUG : sub dir/hello world: copy non-chunked object...
2025/01/12 04:09:44 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli': Waiting for checks to finish
2025/01/12 04:09:44 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli': Waiting for transfers to finish
2025/01/12 04:09:48 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/01/12 04:09:48 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:10:01 INFO  : sub dir/hello world: Deleted
2025/01/12 04:10:03 INFO  : sub dir/hello world.rclone_chunk.001_yp5ab3: Moved (server-side) to: sub dir/hello world
2025/01/12 04:10:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli': Using server-side directory move
2025/01/12 04:10:05 INFO  : Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/01/12 04:10:05 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/01/12 04:10:05 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli': Waiting for checks to finish
2025/01/12 04:10:05 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli': Waiting for transfers to finish
2025/01/12 04:10:09 INFO  : sub dir/hello world: Deleted
2025/01/12 04:10:09 DEBUG : sub dir/hello world: move non-chunked object...
2025/01/12 04:10:11 INFO  : sub dir/hello world: Moved (server-side)
2025/01/12 04:10:11 INFO  : sub dir/hello world: Moved (server-side)
2025/01/12 04:10:20 INFO  : sub dir/hello world.rclone_chunk.001_yp5w0d: Moved (server-side) to: sub dir/hello world
2025/01/12 04:10:22 DEBUG : testing file moves
2025/01/12 04:10:23 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17)
2025/01/12 04:10:23 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli': Waiting for checks to finish
2025/01/12 04:10:23 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli': Waiting for transfers to finish
2025/01/12 04:10:27 INFO  : sub dir/hello world: Deleted
2025/01/12 04:10:27 DEBUG : sub dir/hello world: move non-chunked object...
2025/01/12 04:10:29 INFO  : sub dir/hello world: Moved (server-side)
2025/01/12 04:10:29 INFO  : sub dir/hello world: Moved (server-side)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:10:31 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zubutax2joli': Purge remote
--- PASS: TestServerSideMoveOverSelf (69.27s)
=== RUN   TestSyncDeleteBefore
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:10:53 INFO  : potato.rclone_chunk.001_yp6t39: Moved (server-side) to: potato
2025/01/12 04:11:00 INFO  : empty space.rclone_chunk.001_yp702d: Moved (server-side) to: empty space
2025/01/12 04:11:01 DEBUG : Waiting for deletions to finish
2025/01/12 04:11:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for checks to finish
2025/01/12 04:11:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for transfers to finish
2025/01/12 04:11:05 INFO  : potato: Deleted
2025/01/12 04:11:06 DEBUG : potato2: Need to transfer - File not found at Destination
2025/01/12 04:11:06 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:11:06 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for checks to finish
2025/01/12 04:11:06 DEBUG : empty space: Unchanged skipping
2025/01/12 04:11:06 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for transfers to finish
2025/01/12 04:11:06 DEBUG : potato2: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:11:14 INFO  : potato2.rclone_chunk.001_yp7d69: Moved (server-side) to: potato2.rclone_chunk.001
2025/01/12 04:11:16 INFO  : potato2.rclone_chunk.002_yp7d69: Moved (server-side) to: potato2.rclone_chunk.002
2025/01/12 04:11:18 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2025/01/12 04:11:18 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/01/12 04:11:19 DEBUG : pacer: Reducing sleep to 15ms
2025/01/12 04:11:19 DEBUG : pacer: Reducing sleep to 11.25ms
2025/01/12 04:11:20 DEBUG : pacer: Reducing sleep to 10ms
2025/01/12 04:11:20 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK
2025/01/12 04:11:20 INFO  : potato2: Copied (new)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
--- PASS: TestSyncDeleteBefore (53.89s)
=== RUN   TestCopyDeleteBefore
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:11:46 INFO  : potato.rclone_chunk.001_yp8an7: Moved (server-side) to: potato
2025/01/12 04:11:47 DEBUG : potato2: Need to transfer - File not found at Destination
2025/01/12 04:11:47 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for checks to finish
2025/01/12 04:11:47 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Waiting for transfers to finish
2025/01/12 04:11:48 DEBUG : potato2: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:11:53 INFO  : potato2.rclone_chunk.001_yp8jbg: Moved (server-side) to: potato2
2025/01/12 04:11:53 DEBUG : potato2: md5 = 9519bc2e940e1696ea7365b4b81adedc OK
2025/01/12 04:11:53 INFO  : potato2: Copied (new)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
--- PASS: TestCopyDeleteBefore (24.65s)
=== RUN   TestSyncMultipleCompareDest
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:12:10 INFO  : pre-dest1/1.rclone_chunk.001_yp8zk3: Moved (server-side) to: pre-dest1/1
2025/01/12 04:12:17 INFO  : pre-dest2/2.rclone_chunk.001_yp95lp: Moved (server-side) to: pre-dest2/2
2025/01/12 04:12:18 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dest"
2025/01/12 04:12:18 DEBUG : Creating backend with remote "TestYandex:rclone-test-meromak7fuki/dest"
2025/01/12 04:12:19 DEBUG : Reset feature "ListR"
2025/01/12 04:12:19 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-meromak7fuki/pre-dest1"
2025/01/12 04:12:19 DEBUG : Creating backend with remote "TestYandex:rclone-test-meromak7fuki/pre-dest1"
2025/01/12 04:12:19 DEBUG : Reset feature "ListR"
2025/01/12 04:12:19 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-meromak7fuki/pre-dest2"
2025/01/12 04:12:19 DEBUG : Creating backend with remote "TestYandex:rclone-test-meromak7fuki/pre-dest2"
2025/01/12 04:12:20 DEBUG : Reset feature "ListR"
2025/01/12 04:12:21 DEBUG : 1: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:12:21 DEBUG : 1: Destination found in --compare-dest, skipping
2025/01/12 04:12:22 DEBUG : 2: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:12:22 DEBUG : 2: Destination found in --compare-dest, skipping
2025/01/12 04:12:23 DEBUG : 3: Need to transfer - File not found at Destination
2025/01/12 04:12:23 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dest': Waiting for checks to finish
2025/01/12 04:12:23 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dest': Waiting for transfers to finish
2025/01/12 04:12:23 DEBUG : 3: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:12:29 INFO  : 3.rclone_chunk.001_yp9iw1: Moved (server-side) to: 3
2025/01/12 04:12:29 DEBUG : 3: md5 = eccbc87e4b5ce2fe28308fd9f2a7baf3 OK
2025/01/12 04:12:29 INFO  : 3: Copied (new)
2025/01/12 04:12:29 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncMultipleCompareDest (54.33s)
=== RUN   TestSyncCopyDest
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:12:58 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst"
2025/01/12 04:12:58 DEBUG : Creating backend with remote "TestYandex:rclone-test-meromak7fuki/dst"
2025/01/12 04:12:58 DEBUG : Reset feature "ListR"
2025/01/12 04:12:58 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-meromak7fuki/CopyDest"
2025/01/12 04:12:58 DEBUG : Creating backend with remote "TestYandex:rclone-test-meromak7fuki/CopyDest"
2025/01/12 04:12:59 DEBUG : Reset feature "ListR"
2025/01/12 04:12:59 DEBUG : one: Need to transfer - File not found at Destination
2025/01/12 04:12:59 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for checks to finish
2025/01/12 04:12:59 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for transfers to finish
2025/01/12 04:13:00 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:13:06 INFO  : one.rclone_chunk.001_ypaj6w: Moved (server-side) to: one
2025/01/12 04:13:06 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2025/01/12 04:13:06 INFO  : one: Copied (new)
2025/01/12 04:13:06 DEBUG : Waiting for deletions to finish
2025/01/12 04:13:08 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/01/12 04:13:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for checks to finish
2025/01/12 04:13:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for transfers to finish
2025/01/12 04:13:08 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:13:19 INFO  : one: Deleted
2025/01/12 04:13:21 INFO  : one.rclone_chunk.001_yparly: Moved (server-side) to: one
2025/01/12 04:13:21 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2025/01/12 04:13:21 INFO  : one: Copied (replaced existing)
2025/01/12 04:13:21 DEBUG : Waiting for deletions to finish
2025/01/12 04:13:31 INFO  : dst/one: Deleted
2025/01/12 04:13:33 INFO  : dst/one.rclone_chunk.001_ypb7gi: Moved (server-side) to: dst/one
2025/01/12 04:13:40 INFO  : CopyDest/one.rclone_chunk.001_ypbgdk: Moved (server-side) to: CopyDest/one
2025/01/12 04:13:41 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-meromak7fuki/BackupDir"
2025/01/12 04:13:41 DEBUG : Creating backend with remote "TestYandex:rclone-test-meromak7fuki/BackupDir"
2025/01/12 04:13:41 DEBUG : Reset feature "ListR"
2025/01/12 04:13:42 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/01/12 04:13:42 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for checks to finish
2025/01/12 04:13:43 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:13:43 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/01/12 04:13:44 DEBUG : one: move non-chunked object...
2025/01/12 04:13:45 INFO  : one: Moved (server-side)
2025/01/12 04:13:45 INFO  : one: Moved (server-side)
2025/01/12 04:13:45 DEBUG : one: copy non-chunked object...
2025/01/12 04:13:48 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2025/01/12 04:13:48 INFO  : one: Copied (server-side copy)
2025/01/12 04:13:48 DEBUG : one: Destination found in --copy-dest, using server-side copy
2025/01/12 04:13:48 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for transfers to finish
2025/01/12 04:13:48 DEBUG : Waiting for deletions to finish
2025/01/12 04:13:56 INFO  : CopyDest/two.rclone_chunk.001_ypbwad: Moved (server-side) to: CopyDest/two
2025/01/12 04:13:59 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:13:59 DEBUG : two: copy non-chunked object...
2025/01/12 04:14:02 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2025/01/12 04:14:02 INFO  : two: Copied (server-side copy)
2025/01/12 04:14:02 DEBUG : two: Destination found in --copy-dest, using server-side copy
2025/01/12 04:14:02 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:14:02 DEBUG : one: Unchanged skipping
2025/01/12 04:14:02 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for checks to finish
2025/01/12 04:14:02 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for transfers to finish
2025/01/12 04:14:02 DEBUG : Waiting for deletions to finish
2025/01/12 04:14:04 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:14:04 DEBUG : one: Unchanged skipping
2025/01/12 04:14:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:14:04 DEBUG : two: Unchanged skipping
2025/01/12 04:14:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for checks to finish
2025/01/12 04:14:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for transfers to finish
2025/01/12 04:14:04 DEBUG : Waiting for deletions to finish
2025/01/12 04:14:04 INFO  : There was nothing to transfer
2025/01/12 04:14:10 INFO  : CopyDest/three.rclone_chunk.001_ypcced: Moved (server-side) to: CopyDest/three
2025/01/12 04:14:13 DEBUG : three: Sizes differ (src 7 vs dst 5)
2025/01/12 04:14:13 DEBUG : three: Destination not found in --copy-dest
2025/01/12 04:14:13 DEBUG : three: Need to transfer - File not found at Destination
2025/01/12 04:14:13 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:14:13 DEBUG : one: Unchanged skipping
2025/01/12 04:14:13 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:14:13 DEBUG : two: Unchanged skipping
2025/01/12 04:14:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for checks to finish
2025/01/12 04:14:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for transfers to finish
2025/01/12 04:14:13 DEBUG : three: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:14:20 INFO  : three.rclone_chunk.001_ypckk8: Moved (server-side) to: three
2025/01/12 04:14:20 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK
2025/01/12 04:14:20 INFO  : three: Copied (new)
2025/01/12 04:14:20 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCopyDest (125.25s)
=== RUN   TestSyncBackupDirWithSuffix
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki'", Local "Local file system at /tmp/rclone2891347835", Modify Window "1ns"
2025/01/12 04:15:09 INFO  : dst/one.rclone_chunk.001_ypdzkz: Moved (server-side) to: dst/one
2025/01/12 04:15:16 INFO  : dst/two.rclone_chunk.001_ype5ov: Moved (server-side) to: dst/two
2025/01/12 04:15:24 INFO  : dst/three.txt.rclone_chunk.001_ypecde: Moved (server-side) to: dst/three.txt
2025/01/12 04:15:25 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst"
2025/01/12 04:15:25 DEBUG : Config file has changed externally - reloading
2025/01/12 04:15:25 DEBUG : Creating backend with remote "TestYandex:rclone-test-meromak7fuki/dst"
2025/01/12 04:15:25 DEBUG : Reset feature "ListR"
2025/01/12 04:15:25 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-meromak7fuki/backup"
2025/01/12 04:15:25 DEBUG : Creating backend with remote "TestYandex:rclone-test-meromak7fuki/backup"
2025/01/12 04:15:26 DEBUG : Reset feature "ListR"
2025/01/12 04:15:26 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/01/12 04:15:26 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:15:26 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for checks to finish
2025/01/12 04:15:26 DEBUG : two: Unchanged skipping
2025/01/12 04:15:27 DEBUG : one: move non-chunked object...
2025/01/12 04:15:30 INFO  : one: Moved (server-side) to: one.bak
2025/01/12 04:15:30 INFO  : one: Moved (server-side) to: one.bak
2025/01/12 04:15:30 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for transfers to finish
2025/01/12 04:15:31 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:15:40 INFO  : one.rclone_chunk.001_ypeqpc: Moved (server-side) to: one
2025/01/12 04:15:40 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/01/12 04:15:40 INFO  : one: Copied (new)
2025/01/12 04:15:40 DEBUG : Waiting for deletions to finish
2025/01/12 04:15:41 DEBUG : three.txt: move non-chunked object...
2025/01/12 04:15:44 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/01/12 04:15:44 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/01/12 04:15:44 INFO  : three.txt: Moved into backup dir
2025/01/12 04:15:51 INFO  : dst/three.txt.rclone_chunk.001_ypf4co: Moved (server-side) to: dst/three.txt
2025/01/12 04:15:53 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/01/12 04:15:53 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/01/12 04:15:53 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for checks to finish
2025/01/12 04:15:53 DEBUG : two: Unchanged skipping
2025/01/12 04:15:58 INFO  : one.bak: Deleted
2025/01/12 04:15:58 DEBUG : one: move non-chunked object...
2025/01/12 04:16:00 INFO  : one: Moved (server-side) to: one.bak
2025/01/12 04:16:00 INFO  : one: Moved (server-side) to: one.bak
2025/01/12 04:16:00 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki/dst': Waiting for transfers to finish
2025/01/12 04:16:00 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2025/01/12 04:16:10 INFO  : one.rclone_chunk.001_ypfjnm: Moved (server-side) to: one
2025/01/12 04:16:10 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/01/12 04:16:10 INFO  : one: Copied (new)
2025/01/12 04:16:10 DEBUG : Waiting for deletions to finish
2025/01/12 04:16:15 INFO  : three.txt.bak: Deleted
2025/01/12 04:16:15 DEBUG : three.txt: move non-chunked object...
2025/01/12 04:16:17 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/01/12 04:16:17 INFO  : three.txt: Moved (server-side) to: three.txt.bak
2025/01/12 04:16:17 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDirWithSuffix (98.97s)
PASS
2025/01/12 04:16:42 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-meromak7fuki': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestCopyDeleteBefore|TestCopyOverSelf|TestServerSideMoveOverSelf|TestSyncBackupDirWithSuffix|TestSyncCopyDest|TestSyncDeleteBefore|TestSyncMultipleCompareDest|TestSyncNoEmptyDirectories)$'" - Finished OK in 8m9.748643992s (try 2/5)