"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bMailru: -verbose -fast-list -size-limit 10240 -test.run '^(TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncCompareDest|TestSyncOverlapWithFilter)$'" - Starting (try 4/5)
2024/11/08 01:27:45 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-nowaquc2gano"
2024/11/08 01:27:45 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/08 01:27:45 DEBUG : Creating backend with remote "TestMailru:rclone-test-nowaquc2gano"
2024/11/08 01:27:45 DEBUG : Reset feature "ListR"
2024/11/08 01:27:45 DEBUG : Creating backend with remote "/tmp/rclone3964775233"
=== RUN   TestServerSideCopy
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:27:45 DEBUG : [rclone-test-nowaquc2gano]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:27:46 INFO  : sub dir/hello world.rclone_chunk.001_m4akdi: Moved (server-side) to: sub dir/hello world
2024/11/08 01:27:47 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-vohawih5cepe"
2024/11/08 01:27:47 DEBUG : Creating backend with remote "TestMailru:rclone-test-vohawih5cepe"
2024/11/08 01:27:47 DEBUG : Reset feature "ListR"
    sync_test.go:590: Server side copy (if possible) Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano' -> Chunked 'TestChunkerChunk50bMailru:rclone-test-vohawih5cepe'
2024/11/08 01:27:47 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/08 01:27:47 DEBUG : sub dir/hello world: copy non-chunked object...
2024/11/08 01:27:47 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-vohawih5cepe': Waiting for checks to finish
2024/11/08 01:27:47 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-vohawih5cepe': Waiting for transfers to finish
2024/11/08 01:27:47 DEBUG : [rclone-test-vohawih5cepe]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:27:47 DEBUG : [rclone-test-vohawih5cepe]: mkDirs by part "/rclone-test-vohawih5cepe/sub dir"
2024/11/08 01:27:48 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:27:48 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-vohawih5cepe': Purge remote
--- PASS: TestServerSideCopy (3.83s)
=== RUN   TestServerSideCopyOverSelf
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:27:50 INFO  : sub dir/hello world.rclone_chunk.001_m4anbf: Moved (server-side) to: sub dir/hello world
2024/11/08 01:27:50 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-ziwuxup2paxo"
2024/11/08 01:27:50 DEBUG : Creating backend with remote "TestMailru:rclone-test-ziwuxup2paxo"
2024/11/08 01:27:50 DEBUG : Reset feature "ListR"
    sync_test.go:626: Server side copy (if possible) Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano' -> Chunked 'TestChunkerChunk50bMailru:rclone-test-ziwuxup2paxo'
2024/11/08 01:27:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/08 01:27:51 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-ziwuxup2paxo': Waiting for checks to finish
2024/11/08 01:27:51 DEBUG : sub dir/hello world: copy non-chunked object...
2024/11/08 01:27:51 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-ziwuxup2paxo': Waiting for transfers to finish
2024/11/08 01:27:51 DEBUG : [rclone-test-ziwuxup2paxo]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:27:51 DEBUG : [rclone-test-ziwuxup2paxo]: mkDirs by part "/rclone-test-ziwuxup2paxo/sub dir"
2024/11/08 01:27:51 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:27:53 INFO  : sub dir/hello world: Deleted
2024/11/08 01:27:53 INFO  : sub dir/hello world.rclone_chunk.001_m4aqqa: Moved (server-side) to: sub dir/hello world
2024/11/08 01:27:53 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2024/11/08 01:27:53 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-ziwuxup2paxo': Waiting for checks to finish
2024/11/08 01:27:53 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-ziwuxup2paxo': Waiting for transfers to finish
2024/11/08 01:27:53 DEBUG : sub dir/hello world: copy non-chunked object...
2024/11/08 01:27:54 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:27:54 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-ziwuxup2paxo': Purge remote
--- PASS: TestServerSideCopyOverSelf (6.22s)
=== RUN   TestServerSideMoveOverSelf
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:27:56 INFO  : sub dir/hello world.rclone_chunk.001_m4atlo: Moved (server-side) to: sub dir/hello world
2024/11/08 01:27:56 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-cogozet5jofo"
2024/11/08 01:27:56 DEBUG : Creating backend with remote "TestMailru:rclone-test-cogozet5jofo"
2024/11/08 01:27:57 DEBUG : Reset feature "ListR"
    sync_test.go:671: Server side copy (if possible) Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano' -> Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo'
2024/11/08 01:27:57 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/08 01:27:57 DEBUG : sub dir/hello world: copy non-chunked object...
2024/11/08 01:27:57 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo': Waiting for checks to finish
2024/11/08 01:27:57 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo': Waiting for transfers to finish
2024/11/08 01:27:57 DEBUG : [rclone-test-cogozet5jofo]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:27:57 DEBUG : [rclone-test-cogozet5jofo]: mkDirs by part "/rclone-test-cogozet5jofo/sub dir"
2024/11/08 01:27:58 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:27:59 INFO  : sub dir/hello world: Deleted
2024/11/08 01:27:59 INFO  : sub dir/hello world.rclone_chunk.001_m4aw5t: Moved (server-side) to: sub dir/hello world
2024/11/08 01:27:59 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo': Using server-side directory move
2024/11/08 01:27:59 INFO  : Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2024/11/08 01:28:00 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo': Waiting for checks to finish
2024/11/08 01:28:00 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2024/11/08 01:28:00 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo': Waiting for transfers to finish
2024/11/08 01:28:00 INFO  : sub dir/hello world: Deleted
2024/11/08 01:28:00 DEBUG : sub dir/hello world: move non-chunked object...
2024/11/08 01:28:00 INFO  : sub dir/hello world: Moved (server-side)
2024/11/08 01:28:00 INFO  : sub dir/hello world: Moved (server-side)
2024/11/08 01:28:01 DEBUG : [rclone-test-nowaquc2gano]: new upload shard: https://uploader.cloud.mail.ru/upload/
2024/11/08 01:28:02 INFO  : sub dir/hello world.rclone_chunk.001_m4ay03: Moved (server-side) to: sub dir/hello world
2024/11/08 01:28:02 DEBUG : testing file moves
2024/11/08 01:28:02 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17)
2024/11/08 01:28:02 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo': Waiting for checks to finish
2024/11/08 01:28:02 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo': Waiting for transfers to finish
2024/11/08 01:28:02 INFO  : sub dir/hello world: Deleted
2024/11/08 01:28:02 DEBUG : sub dir/hello world: move non-chunked object...
2024/11/08 01:28:02 INFO  : sub dir/hello world: Moved (server-side)
2024/11/08 01:28:02 INFO  : sub dir/hello world: Moved (server-side)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:28:03 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-cogozet5jofo': Purge remote
--- PASS: TestServerSideMoveOverSelf (8.77s)
=== RUN   TestServerSideMove
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:28:04 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-poxusoc9meci"
2024/11/08 01:28:04 DEBUG : Creating backend with remote "TestMailru:rclone-test-poxusoc9meci"
2024/11/08 01:28:04 DEBUG : Reset feature "ListR"
2024/11/08 01:28:05 INFO  : potato2.rclone_chunk.001_m4b2hu: Moved (server-side) to: potato2.rclone_chunk.001
2024/11/08 01:28:06 INFO  : potato2.rclone_chunk.002_m4b2hu: Moved (server-side) to: potato2.rclone_chunk.002
2024/11/08 01:28:07 INFO  : empty space.rclone_chunk.001_m4b4e1: Moved (server-side) to: empty space
2024/11/08 01:28:08 INFO  : potato3.rclone_chunk.001_m4b5kx: Moved (server-side) to: potato3.rclone_chunk.001
2024/11/08 01:28:09 INFO  : potato3.rclone_chunk.002_m4b5kx: Moved (server-side) to: potato3.rclone_chunk.002
    sync_test.go:1705: Server side move (if possible) Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano' -> Chunked 'TestChunkerChunk50bMailru:rclone-test-poxusoc9meci'
2024/11/08 01:28:10 DEBUG : [rclone-test-poxusoc9meci]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:28:11 INFO  : empty space.rclone_chunk.001_m4b87n: Moved (server-side) to: empty space
2024/11/08 01:28:11 DEBUG : [rclone-test-poxusoc9meci]: new upload shard: https://uploader.cloud.mail.ru/upload/
2024/11/08 01:28:12 INFO  : potato3.rclone_chunk.001_m4b9ci: Moved (server-side) to: potato3.rclone_chunk.001
2024/11/08 01:28:12 INFO  : potato3.rclone_chunk.002_m4b9ci: Moved (server-side) to: potato3.rclone_chunk.002
2024/11/08 01:28:13 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-poxusoc9meci': Using server-side directory move
2024/11/08 01:28:13 INFO  : Chunked 'TestChunkerChunk50bMailru:rclone-test-poxusoc9meci': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2024/11/08 01:28:13 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/08 01:28:13 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s)
2024/11/08 01:28:13 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2024/11/08 01:28:13 DEBUG : empty space: Unchanged skipping
2024/11/08 01:28:13 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-poxusoc9meci': Waiting for checks to finish
2024/11/08 01:28:13 INFO  : empty space: Deleted
2024/11/08 01:28:13 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-poxusoc9meci': Waiting for transfers to finish
2024/11/08 01:28:13 DEBUG : [rclone-test-poxusoc9meci]: Switch file server: locks 1, url https://cloclo51.datacloudmail.ru/oauth-get/, expiry "2024-11-08T01:31:13.761759483Z"
2024/11/08 01:28:13 DEBUG : [rclone-test-nowaquc2gano]: Switch file server: locks 1, url https://cloclo58.datacloudmail.ru/oauth-get/, expiry "2024-11-08T01:31:13.847817409Z"
2024/11/08 01:28:14 DEBUG : [rclone-test-nowaquc2gano]: Unlock file server: locks 0, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:14 DEBUG : potato2: move 2 data chunks...
2024/11/08 01:28:14 DEBUG : [rclone-test-poxusoc9meci]: Unlock file server: locks 0, url https://cloclo51.datacloudmail.ru/oauth-get/
2024/11/08 01:28:14 INFO  : potato2.rclone_chunk.001: Moved (server-side)
2024/11/08 01:28:14 INFO  : potato3: Deleted
2024/11/08 01:28:14 DEBUG : [rclone-test-nowaquc2gano]: Lock file server:   locks 1, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:15 DEBUG : [rclone-test-nowaquc2gano]: Unlock file server: locks 0, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:15 DEBUG : potato3: move 2 data chunks...
2024/11/08 01:28:15 INFO  : potato2.rclone_chunk.002: Moved (server-side)
2024/11/08 01:28:15 INFO  : potato3.rclone_chunk.001: Moved (server-side)
2024/11/08 01:28:15 INFO  : potato2: Moved (server-side)
2024/11/08 01:28:16 DEBUG : potato2: File has been put by hash from source
2024/11/08 01:28:16 INFO  : potato2: Moved (server-side)
2024/11/08 01:28:16 INFO  : potato3.rclone_chunk.002: Moved (server-side)
2024/11/08 01:28:16 INFO  : potato3: Moved (server-side)
2024/11/08 01:28:16 DEBUG : potato3: File has been put by hash from source
2024/11/08 01:28:16 INFO  : potato3: Moved (server-side)
2024/11/08 01:28:16 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-kenefar8vugu"
2024/11/08 01:28:16 DEBUG : Creating backend with remote "TestMailru:rclone-test-kenefar8vugu"
2024/11/08 01:28:16 DEBUG : Reset feature "ListR"
2024/11/08 01:28:16 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-kenefar8vugu': Using server-side directory move
2024/11/08 01:28:17 DEBUG : [rclone-test-kenefar8vugu]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:28:17 INFO  : Chunked 'TestChunkerChunk50bMailru:rclone-test-kenefar8vugu': Server side directory move succeeded
2024/11/08 01:28:17 ERROR : : error listing: directory not found
2024/11/08 01:28:17 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-kenefar8vugu': Purge remote
2024/11/08 01:28:17 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-poxusoc9meci': Purge remote
2024/11/08 01:28:17 NOTICE: purge failed: purge failed: object not found
--- PASS: TestServerSideMove (13.55s)
=== RUN   TestServerSideMoveWithFilter
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:28:17 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-dogexeb7boze"
2024/11/08 01:28:17 DEBUG : Creating backend with remote "TestMailru:rclone-test-dogexeb7boze"
2024/11/08 01:28:18 DEBUG : Reset feature "ListR"
2024/11/08 01:28:19 INFO  : potato2.rclone_chunk.001_m4bg3n: Moved (server-side) to: potato2.rclone_chunk.001
2024/11/08 01:28:19 INFO  : potato2.rclone_chunk.002_m4bg3n: Moved (server-side) to: potato2.rclone_chunk.002
2024/11/08 01:28:21 INFO  : empty space.rclone_chunk.001_m4bi8z: Moved (server-side) to: empty space
2024/11/08 01:28:22 INFO  : potato3.rclone_chunk.001_m4bjkb: Moved (server-side) to: potato3.rclone_chunk.001
2024/11/08 01:28:22 INFO  : potato3.rclone_chunk.002_m4bjkb: Moved (server-side) to: potato3.rclone_chunk.002
    sync_test.go:1705: Server side move (if possible) Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano' -> Chunked 'TestChunkerChunk50bMailru:rclone-test-dogexeb7boze'
2024/11/08 01:28:23 DEBUG : [rclone-test-dogexeb7boze]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:28:24 INFO  : empty space.rclone_chunk.001_m4bl5g: Moved (server-side) to: empty space
2024/11/08 01:28:25 DEBUG : [rclone-test-dogexeb7boze]: new upload shard: https://uploader.cloud.mail.ru/upload/
2024/11/08 01:28:26 INFO  : potato3.rclone_chunk.001_m4bmj9: Moved (server-side) to: potato3.rclone_chunk.001
2024/11/08 01:28:26 INFO  : potato3.rclone_chunk.002_m4bmj9: Moved (server-side) to: potato3.rclone_chunk.002
2024/11/08 01:28:27 DEBUG : empty space: Excluded (Size Filter)
2024/11/08 01:28:27 DEBUG : empty space: Excluded
2024/11/08 01:28:27 DEBUG : empty space: Excluded (Size Filter)
2024/11/08 01:28:27 DEBUG : empty space: Excluded
2024/11/08 01:28:27 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/08 01:28:27 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2024/11/08 01:28:27 DEBUG : [rclone-test-nowaquc2gano]: Lock file server:   locks 1, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:27 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-dogexeb7boze': Waiting for checks to finish
2024/11/08 01:28:27 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-dogexeb7boze': Waiting for transfers to finish
2024/11/08 01:28:27 DEBUG : [rclone-test-nowaquc2gano]: Unlock file server: locks 0, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:27 DEBUG : potato2: move 2 data chunks...
2024/11/08 01:28:27 DEBUG : [rclone-test-dogexeb7boze]: Switch file server: locks 1, url https://cloclo57.datacloudmail.ru/oauth-get/, expiry "2024-11-08T01:31:27.149590403Z"
2024/11/08 01:28:27 INFO  : potato2.rclone_chunk.001: Moved (server-side)
2024/11/08 01:28:27 DEBUG : [rclone-test-dogexeb7boze]: Unlock file server: locks 0, url https://cloclo57.datacloudmail.ru/oauth-get/
2024/11/08 01:28:27 INFO  : potato2.rclone_chunk.002: Moved (server-side)
2024/11/08 01:28:28 INFO  : potato3: Deleted
2024/11/08 01:28:28 DEBUG : [rclone-test-nowaquc2gano]: Lock file server:   locks 1, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:28 DEBUG : [rclone-test-nowaquc2gano]: Unlock file server: locks 0, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:28 DEBUG : potato3: move 2 data chunks...
2024/11/08 01:28:28 INFO  : potato2: Moved (server-side)
2024/11/08 01:28:28 DEBUG : potato2: File has been put by hash from source
2024/11/08 01:28:28 INFO  : potato2: Moved (server-side)
2024/11/08 01:28:29 INFO  : potato3.rclone_chunk.001: Moved (server-side)
2024/11/08 01:28:29 INFO  : potato3.rclone_chunk.002: Moved (server-side)
2024/11/08 01:28:29 INFO  : potato3: Moved (server-side)
2024/11/08 01:28:29 DEBUG : potato3: File has been put by hash from source
2024/11/08 01:28:29 INFO  : potato3: Moved (server-side)
2024/11/08 01:28:30 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-minipum1diva"
2024/11/08 01:28:30 DEBUG : Creating backend with remote "TestMailru:rclone-test-minipum1diva"
2024/11/08 01:28:30 DEBUG : Reset feature "ListR"
2024/11/08 01:28:30 DEBUG : empty space: Excluded (Size Filter)
2024/11/08 01:28:30 DEBUG : empty space: Excluded
2024/11/08 01:28:30 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/08 01:28:30 DEBUG : potato3: Need to transfer - File not found at Destination
2024/11/08 01:28:30 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-minipum1diva': Waiting for checks to finish
2024/11/08 01:28:30 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-minipum1diva': Waiting for transfers to finish
2024/11/08 01:28:30 DEBUG : [rclone-test-dogexeb7boze]: Lock file server:   locks 1, url https://cloclo57.datacloudmail.ru/oauth-get/
2024/11/08 01:28:30 DEBUG : [rclone-test-dogexeb7boze]: Unlock file server: locks 0, url https://cloclo57.datacloudmail.ru/oauth-get/
2024/11/08 01:28:30 DEBUG : potato2: move 2 data chunks...
2024/11/08 01:28:30 DEBUG : [rclone-test-dogexeb7boze]: Lock file server:   locks 1, url https://cloclo57.datacloudmail.ru/oauth-get/
2024/11/08 01:28:30 DEBUG : [rclone-test-dogexeb7boze]: Unlock file server: locks 0, url https://cloclo57.datacloudmail.ru/oauth-get/
2024/11/08 01:28:30 DEBUG : potato3: move 2 data chunks...
2024/11/08 01:28:30 DEBUG : [rclone-test-minipum1diva]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:28:30 INFO  : potato2.rclone_chunk.001: Moved (server-side)
2024/11/08 01:28:30 INFO  : potato3.rclone_chunk.001: Moved (server-side)
2024/11/08 01:28:31 INFO  : potato2.rclone_chunk.002: Moved (server-side)
2024/11/08 01:28:31 INFO  : potato3.rclone_chunk.002: Moved (server-side)
2024/11/08 01:28:32 INFO  : potato2: Moved (server-side)
2024/11/08 01:28:32 INFO  : potato3: Moved (server-side)
2024/11/08 01:28:32 DEBUG : potato2: File has been put by hash from source
2024/11/08 01:28:32 INFO  : potato2: Moved (server-side)
2024/11/08 01:28:32 DEBUG : potato3: File has been put by hash from source
2024/11/08 01:28:32 INFO  : potato3: Moved (server-side)
2024/11/08 01:28:32 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-minipum1diva': Purge remote
2024/11/08 01:28:33 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-dogexeb7boze': Purge remote
--- PASS: TestServerSideMoveWithFilter (15.54s)
=== RUN   TestServerSideMoveDeleteEmptySourceDirs
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:28:33 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-lupusow7bebu"
2024/11/08 01:28:33 DEBUG : Creating backend with remote "TestMailru:rclone-test-lupusow7bebu"
2024/11/08 01:28:33 DEBUG : Reset feature "ListR"
2024/11/08 01:28:35 INFO  : potato2.rclone_chunk.001_m4bvpw: Moved (server-side) to: potato2.rclone_chunk.001
2024/11/08 01:28:35 INFO  : potato2.rclone_chunk.002_m4bvpw: Moved (server-side) to: potato2.rclone_chunk.002
2024/11/08 01:28:36 INFO  : empty space.rclone_chunk.001_m4bxg0: Moved (server-side) to: empty space
2024/11/08 01:28:38 INFO  : potato3.rclone_chunk.001_m4bydd: Moved (server-side) to: potato3.rclone_chunk.001
2024/11/08 01:28:38 INFO  : potato3.rclone_chunk.002_m4bydd: Moved (server-side) to: potato3.rclone_chunk.002
2024/11/08 01:28:38 DEBUG : tomatoDir: Making directory
    sync_test.go:1705: Server side move (if possible) Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano' -> Chunked 'TestChunkerChunk50bMailru:rclone-test-lupusow7bebu'
2024/11/08 01:28:39 DEBUG : [rclone-test-lupusow7bebu]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:28:40 INFO  : empty space.rclone_chunk.001_m4c12t: Moved (server-side) to: empty space
2024/11/08 01:28:40 DEBUG : [rclone-test-lupusow7bebu]: new upload shard: https://uploader.cloud.mail.ru/upload/
2024/11/08 01:28:42 INFO  : potato3.rclone_chunk.001_m4c2iq: Moved (server-side) to: potato3.rclone_chunk.001
2024/11/08 01:28:42 INFO  : potato3.rclone_chunk.002_m4c2iq: Moved (server-side) to: potato3.rclone_chunk.002
2024/11/08 01:28:42 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-lupusow7bebu': Using server-side directory move
2024/11/08 01:28:42 INFO  : Chunked 'TestChunkerChunk50bMailru:rclone-test-lupusow7bebu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2024/11/08 01:28:43 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/08 01:28:43 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s)
2024/11/08 01:28:43 DEBUG : empty space: Unchanged skipping
2024/11/08 01:28:43 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2024/11/08 01:28:43 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-lupusow7bebu': Waiting for checks to finish
2024/11/08 01:28:43 DEBUG : [rclone-test-nowaquc2gano]: Lock file server:   locks 1, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:43 DEBUG : [rclone-test-nowaquc2gano]: Unlock file server: locks 0, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:43 DEBUG : potato2: move 2 data chunks...
2024/11/08 01:28:43 DEBUG : [rclone-test-lupusow7bebu]: Switch file server: locks 1, url https://cloclo61.datacloudmail.ru/oauth-get/, expiry "2024-11-08T01:31:43.099891482Z"
2024/11/08 01:28:43 INFO  : empty space: Deleted
2024/11/08 01:28:43 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-lupusow7bebu': Waiting for transfers to finish
2024/11/08 01:28:43 DEBUG : [rclone-test-lupusow7bebu]: Unlock file server: locks 0, url https://cloclo61.datacloudmail.ru/oauth-get/
2024/11/08 01:28:43 INFO  : potato2.rclone_chunk.001: Moved (server-side)
2024/11/08 01:28:44 INFO  : potato3: Deleted
2024/11/08 01:28:44 DEBUG : [rclone-test-nowaquc2gano]: Lock file server:   locks 1, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:44 DEBUG : [rclone-test-nowaquc2gano]: Unlock file server: locks 0, url https://cloclo58.datacloudmail.ru/oauth-get/
2024/11/08 01:28:44 DEBUG : potato3: move 2 data chunks...
2024/11/08 01:28:44 INFO  : potato2.rclone_chunk.002: Moved (server-side)
2024/11/08 01:28:44 INFO  : potato3.rclone_chunk.001: Moved (server-side)
2024/11/08 01:28:44 INFO  : potato2: Moved (server-side)
2024/11/08 01:28:45 DEBUG : potato2: File has been put by hash from source
2024/11/08 01:28:45 INFO  : potato2: Moved (server-side)
2024/11/08 01:28:45 INFO  : potato3.rclone_chunk.002: Moved (server-side)
2024/11/08 01:28:45 INFO  : potato3: Moved (server-side)
2024/11/08 01:28:45 DEBUG : potato3: File has been put by hash from source
2024/11/08 01:28:45 INFO  : potato3: Moved (server-side)
2024/11/08 01:28:45 INFO  : tomatoDir: Removing directory
2024/11/08 01:28:45 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano': deleted 1 directories
2024/11/08 01:28:46 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-bapapuz0leku"
2024/11/08 01:28:46 DEBUG : Creating backend with remote "TestMailru:rclone-test-bapapuz0leku"
2024/11/08 01:28:46 DEBUG : Reset feature "ListR"
2024/11/08 01:28:46 DEBUG : tomatoDir: Making directory
2024/11/08 01:28:46 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-bapapuz0leku': Using server-side directory move
2024/11/08 01:28:46 DEBUG : [rclone-test-bapapuz0leku]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:28:46 INFO  : Chunked 'TestChunkerChunk50bMailru:rclone-test-bapapuz0leku': Server side directory move succeeded
2024/11/08 01:28:47 ERROR : : error listing: directory not found
2024/11/08 01:28:47 ERROR : : error listing: directory not found
2024/11/08 01:28:47 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-bapapuz0leku': Purge remote
2024/11/08 01:28:47 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-lupusow7bebu': Purge remote
2024/11/08 01:28:47 NOTICE: purge failed: purge failed: object not found
--- PASS: TestServerSideMoveDeleteEmptySourceDirs (14.29s)
=== RUN   TestSyncOverlapWithFilter
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:28:47 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/rclone-sync-test"
2024/11/08 01:28:47 DEBUG : Creating backend with remote "TestMailru:rclone-test-nowaquc2gano/rclone-sync-test"
2024/11/08 01:28:47 DEBUG : Reset feature "ListR"
2024/11/08 01:28:48 DEBUG : [rclone-test-nowaquc2gano/rclone-sync-test]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:28:48 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/rclone-sync-test-include/layer2"
2024/11/08 01:28:48 DEBUG : Creating backend with remote "TestMailru:rclone-test-nowaquc2gano/rclone-sync-test-include/layer2"
2024/11/08 01:28:48 DEBUG : Reset feature "ListR"
2024/11/08 01:28:48 DEBUG : [rclone-test-nowaquc2gano/rclone-sync-test-include/layer2]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:28:48 DEBUG : [rclone-test-nowaquc2gano/rclone-sync-test-include/layer2]: mkDirs by part "/rclone-test-nowaquc2gano/rclone-sync-test-include/layer2"
2024/11/08 01:28:48 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/rclone-sync-test-ignore-file"
2024/11/08 01:28:48 DEBUG : Creating backend with remote "TestMailru:rclone-test-nowaquc2gano/rclone-sync-test-ignore-file"
2024/11/08 01:28:48 DEBUG : Reset feature "ListR"
2024/11/08 01:28:49 DEBUG : [rclone-test-nowaquc2gano/rclone-sync-test-ignore-file]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:28:50 INFO  : rclone-sync-test-ignore-file/.ignore.rclone_chunk.001_m4cbdh: Moved (server-side) to: rclone-sync-test-ignore-file/.ignore
2024/11/08 01:28:50 DEBUG : rclone-sync-test: Excluded
2024/11/08 01:28:50 DEBUG : rclone-sync-test-ignore-file: Excluded
2024/11/08 01:28:51 DEBUG : rclone-sync-test-include/layer2: Excluded
2024/11/08 01:28:51 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/rclone-sync-test': Waiting for checks to finish
2024/11/08 01:28:51 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/rclone-sync-test': Waiting for transfers to finish
2024/11/08 01:28:51 DEBUG : Waiting for deletions to finish
2024/11/08 01:28:51 INFO  : There was nothing to transfer
2024/11/08 01:28:51 DEBUG : rclone-sync-test: Excluded
2024/11/08 01:28:51 DEBUG : rclone-sync-test-ignore-file: Excluded
2024/11/08 01:28:51 DEBUG : rclone-sync-test-include/layer2: Excluded
2024/11/08 01:28:51 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano': Waiting for checks to finish
2024/11/08 01:28:51 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano': Waiting for transfers to finish
2024/11/08 01:28:51 DEBUG : Waiting for deletions to finish
2024/11/08 01:28:51 INFO  : rclone-sync-test-include: Removing directory
2024/11/08 01:28:52 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty
2024/11/08 01:28:52 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano': failed to delete 1 directories
2024/11/08 01:28:52 INFO  : There was nothing to transfer
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:28:52 DEBUG : rclone-sync-test: Excluded
2024/11/08 01:28:52 DEBUG : rclone-sync-test-ignore-file: Excluded
2024/11/08 01:28:52 DEBUG : rclone-sync-test-include/layer2: Excluded
2024/11/08 01:28:52 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/rclone-sync-test-include/layer2': Waiting for checks to finish
2024/11/08 01:28:52 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/rclone-sync-test-include/layer2': Waiting for transfers to finish
2024/11/08 01:28:52 DEBUG : Waiting for deletions to finish
2024/11/08 01:28:52 INFO  : There was nothing to transfer
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:28:53 DEBUG : rclone-sync-test: Excluded
2024/11/08 01:28:53 DEBUG : rclone-sync-test-ignore-file: Excluded
2024/11/08 01:28:53 DEBUG : rclone-sync-test-include/layer2: Excluded
2024/11/08 01:28:53 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano': Waiting for checks to finish
2024/11/08 01:28:53 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano': Waiting for transfers to finish
2024/11/08 01:28:53 DEBUG : Waiting for deletions to finish
2024/11/08 01:28:53 INFO  : rclone-sync-test-include: Removing directory
2024/11/08 01:28:53 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty
2024/11/08 01:28:53 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano': failed to delete 1 directories
2024/11/08 01:28:53 INFO  : There was nothing to transfer
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:28:54 DEBUG : : Excluded
2024/11/08 01:28:54 DEBUG : rclone-sync-test: Excluded
2024/11/08 01:28:54 DEBUG : rclone-sync-test-ignore-file: Excluded
2024/11/08 01:28:54 DEBUG : rclone-sync-test-include/layer2: Excluded
2024/11/08 01:28:54 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/rclone-sync-test-ignore-file': Waiting for checks to finish
2024/11/08 01:28:54 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/rclone-sync-test-ignore-file': Waiting for transfers to finish
2024/11/08 01:28:54 DEBUG : Waiting for deletions to finish
2024/11/08 01:28:54 INFO  : There was nothing to transfer
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
--- PASS: TestSyncOverlapWithFilter (11.95s)
=== RUN   TestSyncCompareDest
    run.go:180: Remote "Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano'", Local "Local file system at /tmp/rclone3964775233", Modify Window "1s"
2024/11/08 01:28:59 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst"
2024/11/08 01:28:59 DEBUG : Creating backend with remote "TestMailru:rclone-test-nowaquc2gano/dst"
2024/11/08 01:28:59 DEBUG : Reset feature "ListR"
2024/11/08 01:28:59 DEBUG : Creating backend with remote "TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/CompareDest"
2024/11/08 01:28:59 DEBUG : Creating backend with remote "TestMailru:rclone-test-nowaquc2gano/CompareDest"
2024/11/08 01:29:00 DEBUG : Reset feature "ListR"
2024/11/08 01:29:00 DEBUG : one: Need to transfer - File not found at Destination
2024/11/08 01:29:00 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for checks to finish
2024/11/08 01:29:00 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for transfers to finish
2024/11/08 01:29:00 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2024/11/08 01:29:00 DEBUG : [rclone-test-nowaquc2gano/dst]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/08 01:29:01 INFO  : one.rclone_chunk.001_m4cmoe: Moved (server-side) to: one
2024/11/08 01:29:01 INFO  : one: Copied (new)
2024/11/08 01:29:01 DEBUG : Waiting for deletions to finish
2024/11/08 01:29:01 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/11/08 01:29:01 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for checks to finish
2024/11/08 01:29:01 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for transfers to finish
2024/11/08 01:29:01 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2024/11/08 01:29:02 INFO  : one: Deleted
2024/11/08 01:29:03 INFO  : one.rclone_chunk.001_m4cn6j: Moved (server-side) to: one
2024/11/08 01:29:03 INFO  : one: Copied (replaced existing)
2024/11/08 01:29:03 DEBUG : Waiting for deletions to finish
2024/11/08 01:29:04 INFO  : dst/one: Deleted
2024/11/08 01:29:04 INFO  : dst/one.rclone_chunk.001_m4cpv7: Moved (server-side) to: dst/one
2024/11/08 01:29:05 INFO  : CompareDest/one.rclone_chunk.001_m4cq7c: Moved (server-side) to: CompareDest/one
2024/11/08 01:29:05 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/11/08 01:29:05 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for checks to finish
2024/11/08 01:29:06 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2024/11/08 01:29:06 DEBUG : one: Destination found in --compare-dest, skipping
2024/11/08 01:29:06 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for transfers to finish
2024/11/08 01:29:06 DEBUG : Waiting for deletions to finish
2024/11/08 01:29:06 INFO  : There was nothing to transfer
2024/11/08 01:29:07 INFO  : CompareDest/two.rclone_chunk.001_m4cs6m: Moved (server-side) to: CompareDest/two
2024/11/08 01:29:07 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2024/11/08 01:29:07 DEBUG : two: Destination found in --compare-dest, skipping
2024/11/08 01:29:07 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/11/08 01:29:07 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for checks to finish
2024/11/08 01:29:08 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2024/11/08 01:29:08 DEBUG : one: Destination found in --compare-dest, skipping
2024/11/08 01:29:08 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for transfers to finish
2024/11/08 01:29:08 DEBUG : Waiting for deletions to finish
2024/11/08 01:29:08 INFO  : There was nothing to transfer
2024/11/08 01:29:08 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2024/11/08 01:29:08 DEBUG : two: Destination found in --compare-dest, skipping
2024/11/08 01:29:08 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/11/08 01:29:08 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for checks to finish
2024/11/08 01:29:08 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2024/11/08 01:29:08 DEBUG : one: Destination found in --compare-dest, skipping
2024/11/08 01:29:08 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for transfers to finish
2024/11/08 01:29:08 DEBUG : Waiting for deletions to finish
2024/11/08 01:29:08 INFO  : There was nothing to transfer
    sync_test.go:2175: No hash on uploaded file so skipping compare timestamp test
2024/11/08 01:29:09 DEBUG : two: Sizes differ (src 5 vs dst 3)
2024/11/08 01:29:09 DEBUG : two: Need to transfer - File not found at Destination
2024/11/08 01:29:09 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/11/08 01:29:09 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for checks to finish
2024/11/08 01:29:09 DEBUG : two: skip slow MD5 on source file, hashing in-transit
2024/11/08 01:29:10 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2024/11/08 01:29:10 DEBUG : one: Destination found in --compare-dest, skipping
2024/11/08 01:29:10 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano/dst': Waiting for transfers to finish
2024/11/08 01:29:10 INFO  : two.rclone_chunk.001_m4cvn9: Moved (server-side) to: two
2024/11/08 01:29:10 INFO  : two: Copied (new)
2024/11/08 01:29:10 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCompareDest (12.57s)
PASS
2024/11/08 01:29:12 DEBUG : Chunked 'TestChunkerChunk50bMailru:rclone-test-nowaquc2gano': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bMailru: -verbose -fast-list -size-limit 10240 -test.run '^(TestServerSideCopy|TestServerSideCopyOverSelf|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncCompareDest|TestSyncOverlapWithFilter)$'" - Finished OK in 1m27.136620726s (try 4/5)