"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideCopyOverSelf|TestSyncCopyDest)$'" - Starting (try 2/5)
2025/03/24 07:07:15 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lobedag4niga"
2025/03/24 07:07:15 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/24 07:07:15 DEBUG : Creating backend with remote "TestYandex:rclone-test-lobedag4niga"
2025/03/24 07:07:15 DEBUG : Reset feature "ListR"
2025/03/24 07:07:15 DEBUG : Creating backend with remote "/tmp/rclone2434722803"
=== RUN   TestServerSideCopyOverSelf
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga'", Local "Local file system at /tmp/rclone2434722803", Modify Window "1ns"
2025/03/24 07:07:22 INFO  : sub dir/hello world.rclone_chunk.001_meprto: Moved (server-side) to: sub dir/hello world
2025/03/24 07:07:23 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-wazonab8taku"
2025/03/24 07:07:23 DEBUG : Creating backend with remote "TestYandex:rclone-test-wazonab8taku"
2025/03/24 07:07:23 DEBUG : Reset feature "ListR"
    sync_test.go:626: Server side copy (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-wazonab8taku'
2025/03/24 07:07:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/03/24 07:07:24 DEBUG : sub dir/hello world: copy non-chunked object...
2025/03/24 07:07:24 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wazonab8taku': Waiting for checks to finish
2025/03/24 07:07:24 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wazonab8taku': Waiting for transfers to finish
2025/03/24 07:07:28 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/03/24 07:07:28 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga'", Local "Local file system at /tmp/rclone2434722803", Modify Window "1ns"
2025/03/24 07:07:41 INFO  : sub dir/hello world: Deleted
2025/03/24 07:07:43 INFO  : sub dir/hello world.rclone_chunk.001_meq8v0: Moved (server-side) to: sub dir/hello world
2025/03/24 07:07:45 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/03/24 07:07:45 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wazonab8taku': Waiting for checks to finish
2025/03/24 07:07:45 DEBUG : sub dir/hello world: copy non-chunked object...
2025/03/24 07:07:45 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wazonab8taku': Waiting for transfers to finish
2025/03/24 07:07:45 DEBUG : sub dir/hello world: server side copy: renaming existing object to "sub dir/hello world.zelulil3" before starting
2025/03/24 07:07:53 DEBUG : sub dir/hello world.zelulil3: server side copy: removing renamed existing file after operation
2025/03/24 07:07:58 DEBUG : sub dir/hello world: md5 = 00321a507bdb420dbbd4f53c733b1505 OK
2025/03/24 07:07:58 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga'", Local "Local file system at /tmp/rclone2434722803", Modify Window "1ns"
2025/03/24 07:07:59 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wazonab8taku': Purge remote
--- PASS: TestServerSideCopyOverSelf (60.24s)
=== RUN   TestSyncCopyDest
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga'", Local "Local file system at /tmp/rclone2434722803", Modify Window "1ns"
2025/03/24 07:08:16 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst"
2025/03/24 07:08:16 DEBUG : Creating backend with remote "TestYandex:rclone-test-lobedag4niga/dst"
2025/03/24 07:08:16 DEBUG : Reset feature "ListR"
2025/03/24 07:08:16 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lobedag4niga/CopyDest"
2025/03/24 07:08:16 DEBUG : Creating backend with remote "TestYandex:rclone-test-lobedag4niga/CopyDest"
2025/03/24 07:08:17 DEBUG : Reset feature "ListR"
2025/03/24 07:08:17 DEBUG : one: Need to transfer - File not found at Destination
2025/03/24 07:08:17 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for checks to finish
2025/03/24 07:08:17 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for transfers to finish
2025/03/24 07:08:17 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2025/03/24 07:08:23 INFO  : one.rclone_chunk.001_merghw: Moved (server-side) to: one
2025/03/24 07:08:23 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2025/03/24 07:08:23 INFO  : one: Copied (new)
2025/03/24 07:08:23 DEBUG : Waiting for deletions to finish
2025/03/24 07:08:25 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for checks to finish
2025/03/24 07:08:25 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/03/24 07:08:25 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for transfers to finish
2025/03/24 07:08:25 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2025/03/24 07:08:34 INFO  : one: Deleted
2025/03/24 07:08:35 INFO  : one.rclone_chunk.001_mero34: Moved (server-side) to: one
2025/03/24 07:08:35 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2025/03/24 07:08:35 INFO  : one: Copied (replaced existing)
2025/03/24 07:08:35 DEBUG : Waiting for deletions to finish
2025/03/24 07:08:44 INFO  : dst/one: Deleted
2025/03/24 07:08:46 INFO  : dst/one.rclone_chunk.001_mes00f: Moved (server-side) to: dst/one
2025/03/24 07:08:53 INFO  : CopyDest/one.rclone_chunk.001_mes9wn: Moved (server-side) to: CopyDest/one
2025/03/24 07:08:54 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lobedag4niga/BackupDir"
2025/03/24 07:08:54 DEBUG : Creating backend with remote "TestYandex:rclone-test-lobedag4niga/BackupDir"
2025/03/24 07:08:55 DEBUG : Reset feature "ListR"
2025/03/24 07:08:55 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for checks to finish
2025/03/24 07:08:55 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/03/24 07:08:56 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/03/24 07:08:56 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/03/24 07:08:56 DEBUG : one: move non-chunked object...
2025/03/24 07:08:58 INFO  : one: Moved (server-side)
2025/03/24 07:08:58 INFO  : one: Moved (server-side)
2025/03/24 07:08:58 DEBUG : one: copy non-chunked object...
2025/03/24 07:09:01 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2025/03/24 07:09:01 INFO  : one: Copied (server-side copy)
2025/03/24 07:09:01 DEBUG : one: Destination found in --copy-dest, using server-side copy
2025/03/24 07:09:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for transfers to finish
2025/03/24 07:09:01 DEBUG : Waiting for deletions to finish
2025/03/24 07:09:08 INFO  : CopyDest/two.rclone_chunk.001_mesphy: Moved (server-side) to: CopyDest/two
2025/03/24 07:09:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/03/24 07:09:10 DEBUG : two: copy non-chunked object...
2025/03/24 07:09:12 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2025/03/24 07:09:12 INFO  : two: Copied (server-side copy)
2025/03/24 07:09:12 DEBUG : two: Destination found in --copy-dest, using server-side copy
2025/03/24 07:09:12 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for checks to finish
2025/03/24 07:09:12 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/03/24 07:09:12 DEBUG : one: Unchanged skipping
2025/03/24 07:09:12 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for transfers to finish
2025/03/24 07:09:12 DEBUG : Waiting for deletions to finish
2025/03/24 07:09:13 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/03/24 07:09:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for checks to finish
2025/03/24 07:09:13 DEBUG : one: Unchanged skipping
2025/03/24 07:09:13 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/03/24 07:09:13 DEBUG : two: Unchanged skipping
2025/03/24 07:09:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for transfers to finish
2025/03/24 07:09:13 DEBUG : Waiting for deletions to finish
2025/03/24 07:09:13 INFO  : There was nothing to transfer
2025/03/24 07:09:19 INFO  : CopyDest/three.rclone_chunk.001_met1tv: Moved (server-side) to: CopyDest/three
2025/03/24 07:09:20 DEBUG : three: Sizes differ (src 7 vs dst 5)
2025/03/24 07:09:20 DEBUG : three: Destination not found in --copy-dest
2025/03/24 07:09:20 DEBUG : three: Need to transfer - File not found at Destination
2025/03/24 07:09:20 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/03/24 07:09:20 DEBUG : one: Unchanged skipping
2025/03/24 07:09:20 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/03/24 07:09:20 DEBUG : two: Unchanged skipping
2025/03/24 07:09:20 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for checks to finish
2025/03/24 07:09:20 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga/dst': Waiting for transfers to finish
2025/03/24 07:09:21 DEBUG : three: skip slow MD5 on source file, hashing in-transit
2025/03/24 07:09:25 INFO  : three.rclone_chunk.001_met80d: Moved (server-side) to: three
2025/03/24 07:09:25 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK
2025/03/24 07:09:25 INFO  : three: Copied (new)
2025/03/24 07:09:25 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCopyDest (113.53s)
PASS
2025/03/24 07:10:09 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lobedag4niga': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideCopyOverSelf|TestSyncCopyDest)$'" - Finished OK in 2m58.74639767s (try 2/5)