"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestServerSideCopy|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncCompareDest)$'" - Starting (try 2/5)
2024/09/26 02:11:00 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-joxobub7yeki"
2024/09/26 02:11:00 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/09/26 02:11:00 DEBUG : Creating backend with remote "TestYandex:rclone-test-joxobub7yeki"
2024/09/26 02:11:00 DEBUG : Reset feature "ListR"
2024/09/26 02:11:00 DEBUG : Creating backend with remote "/tmp/rclone2808011752"
=== RUN   TestServerSideCopy
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki'", Local "Local file system at /tmp/rclone2808011752", Modify Window "1ns"
2024/09/26 02:11:05 INFO  : sub dir/hello world.rclone_chunk.001_ejm9m6: Moved (server-side) to: sub dir/hello world
2024/09/26 02:11:06 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lodutir6jove"
2024/09/26 02:11:06 DEBUG : Creating backend with remote "TestYandex:rclone-test-lodutir6jove"
2024/09/26 02:11:06 DEBUG : Reset feature "ListR"
    sync_test.go:590: Server side copy (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-lodutir6jove'
2024/09/26 02:11:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/09/26 02:11:07 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lodutir6jove': Waiting for checks to finish
2024/09/26 02:11:07 DEBUG : sub dir/hello world: copy non-chunked object...
2024/09/26 02:11:07 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lodutir6jove': Waiting for transfers to finish
2024/09/26 02:11:09 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2024/09/26 02:11:09 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki'", Local "Local file system at /tmp/rclone2808011752", Modify Window "1ns"
2024/09/26 02:11:11 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lodutir6jove': Purge remote
--- PASS: TestServerSideCopy (16.13s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki'", Local "Local file system at /tmp/rclone2808011752", Modify Window "1ns"
2024/09/26 02:11:21 INFO  : b/potato.rclone_chunk.001_ejmpvw: Moved (server-side) to: b/potato
2024/09/26 02:11:26 INFO  : c/non empty space.rclone_chunk.001_ejmuo1: Moved (server-side) to: c/non empty space
2024/09/26 02:11:26 DEBUG : d: Making directory
2024/09/26 02:11:27 DEBUG : a/potato2: Need to transfer - File not found at Destination
2024/09/26 02:11:28 DEBUG : a/potato2: skip slow MD5 on source file, hashing in-transit
2024/09/26 02:11:28 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/09/26 02:11:28 DEBUG : c/non empty space: Unchanged skipping
2024/09/26 02:11:28 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki': Waiting for checks to finish
2024/09/26 02:11:28 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki': Waiting for transfers to finish
2024/09/26 02:11:34 INFO  : a/potato2.rclone_chunk.001_ejn067: Moved (server-side) to: a/potato2.rclone_chunk.001
2024/09/26 02:11:36 INFO  : a/potato2.rclone_chunk.002_ejn067: Moved (server-side) to: a/potato2.rclone_chunk.002
2024/09/26 02:11:38 DEBUG : a/potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK
2024/09/26 02:11:38 INFO  : a/potato2: Copied (new)
2024/09/26 02:11:38 ERROR : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki': not deleting files as there were IO errors
2024/09/26 02:11:38 ERROR : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki': not deleting directories as there were IO errors
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki'", Local "Local file system at /tmp/rclone2808011752", Modify Window "1ns"
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (38.96s)
=== RUN   TestSyncCompareDest
    run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki'", Local "Local file system at /tmp/rclone2808011752", Modify Window "1ns"
2024/09/26 02:11:55 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst"
2024/09/26 02:11:55 DEBUG : Creating backend with remote "TestYandex:rclone-test-joxobub7yeki/dst"
2024/09/26 02:11:56 DEBUG : Reset feature "ListR"
2024/09/26 02:11:56 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/CompareDest"
2024/09/26 02:11:56 DEBUG : Creating backend with remote "TestYandex:rclone-test-joxobub7yeki/CompareDest"
2024/09/26 02:11:56 DEBUG : Reset feature "ListR"
2024/09/26 02:11:57 DEBUG : one: Need to transfer - File not found at Destination
2024/09/26 02:11:57 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for checks to finish
2024/09/26 02:11:57 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for transfers to finish
2024/09/26 02:11:57 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2024/09/26 02:12:02 INFO  : one.rclone_chunk.001_ejntuq: Moved (server-side) to: one
2024/09/26 02:12:02 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2024/09/26 02:12:02 INFO  : one: Copied (new)
2024/09/26 02:12:02 DEBUG : Waiting for deletions to finish
2024/09/26 02:12:03 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/09/26 02:12:03 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for checks to finish
2024/09/26 02:12:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for transfers to finish
2024/09/26 02:12:04 DEBUG : one: skip slow MD5 on source file, hashing in-transit
2024/09/26 02:12:08 INFO  : one: Deleted
2024/09/26 02:12:11 INFO  : one.rclone_chunk.001_ejo072: Moved (server-side) to: one
2024/09/26 02:12:11 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2024/09/26 02:12:11 INFO  : one: Copied (replaced existing)
2024/09/26 02:12:11 DEBUG : Waiting for deletions to finish
2024/09/26 02:12:20 INFO  : dst/one: Deleted
2024/09/26 02:12:21 INFO  : dst/one.rclone_chunk.001_ejo99y: Moved (server-side) to: dst/one
2024/09/26 02:12:25 INFO  : CompareDest/one.rclone_chunk.001_ejohet: Moved (server-side) to: CompareDest/one
2024/09/26 02:12:26 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/09/26 02:12:26 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for checks to finish
2024/09/26 02:12:27 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/09/26 02:12:27 DEBUG : one: Destination found in --compare-dest, skipping
2024/09/26 02:12:27 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for transfers to finish
2024/09/26 02:12:27 DEBUG : Waiting for deletions to finish
2024/09/26 02:12:27 INFO  : There was nothing to transfer
2024/09/26 02:12:33 INFO  : CompareDest/two.rclone_chunk.001_ejoobj: Moved (server-side) to: CompareDest/two
2024/09/26 02:12:35 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/09/26 02:12:35 DEBUG : two: Destination found in --compare-dest, skipping
2024/09/26 02:12:35 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/09/26 02:12:35 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for checks to finish
2024/09/26 02:12:35 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/09/26 02:12:35 DEBUG : one: Destination found in --compare-dest, skipping
2024/09/26 02:12:35 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for transfers to finish
2024/09/26 02:12:35 DEBUG : Waiting for deletions to finish
2024/09/26 02:12:35 INFO  : There was nothing to transfer
2024/09/26 02:12:37 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/09/26 02:12:37 DEBUG : two: Destination found in --compare-dest, skipping
2024/09/26 02:12:37 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/09/26 02:12:37 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for checks to finish
2024/09/26 02:12:37 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/09/26 02:12:37 DEBUG : one: Destination found in --compare-dest, skipping
2024/09/26 02:12:37 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for transfers to finish
2024/09/26 02:12:37 DEBUG : Waiting for deletions to finish
2024/09/26 02:12:37 INFO  : There was nothing to transfer
2024/09/26 02:12:42 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
2024/09/26 02:12:42 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2024/09/26 02:12:42 DEBUG : two: Destination found in --compare-dest, skipping
2024/09/26 02:12:42 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/09/26 02:12:42 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for checks to finish
2024/09/26 02:12:43 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/09/26 02:12:43 DEBUG : one: Destination found in --compare-dest, skipping
2024/09/26 02:12:43 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for transfers to finish
2024/09/26 02:12:43 DEBUG : Waiting for deletions to finish
2024/09/26 02:12:43 INFO  : There was nothing to transfer
2024/09/26 02:12:45 DEBUG : two: Sizes differ (src 5 vs dst 3)
2024/09/26 02:12:45 DEBUG : two: Need to transfer - File not found at Destination
2024/09/26 02:12:45 DEBUG : one: Sizes differ (src 5 vs dst 3)
2024/09/26 02:12:45 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for checks to finish
2024/09/26 02:12:45 DEBUG : two: skip slow MD5 on source file, hashing in-transit
2024/09/26 02:12:46 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/09/26 02:12:46 DEBUG : one: Destination found in --compare-dest, skipping
2024/09/26 02:12:46 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki/dst': Waiting for transfers to finish
2024/09/26 02:12:49 INFO  : two.rclone_chunk.001_ejp54n: Moved (server-side) to: two
2024/09/26 02:12:49 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK
2024/09/26 02:12:49 INFO  : two: Copied (new)
2024/09/26 02:12:49 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCompareDest (64.90s)
PASS
2024/09/26 02:13:00 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-joxobub7yeki': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestServerSideCopy|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncCompareDest)$'" - Finished OK in 2m1.480532644s (try 2/5)