"./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestNothingToTransferWithoutEmptyDirs|TestServerSideMoveOverSelf|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncBackupDir|TestSyncCompareDest|TestSyncCopyDest|TestSyncDeleteBefore)$'" - Starting (try 2/5)
2025/06/21 02:22:37 DEBUG : Creating backend with remote "TestYandex:rclone-test-jokados3duhi"
2025/06/21 02:22:37 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/06/21 02:22:37 DEBUG : Creating backend with remote "/tmp/rclone1893486284"
=== RUN   TestServerSideMoveOverSelf
    run.go:180: Remote "Yandex rclone-test-jokados3duhi", Local "Local file system at /tmp/rclone1893486284", Modify Window "1ns"
2025/06/21 02:22:40 DEBUG : Creating backend with remote "TestYandex:rclone-test-gitujax1gere"
    sync_test.go:672: Server side copy (if possible) Yandex rclone-test-jokados3duhi -> Yandex rclone-test-gitujax1gere
2025/06/21 02:22:41 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/06/21 02:22:41 DEBUG : Yandex rclone-test-gitujax1gere: Waiting for checks to finish
2025/06/21 02:22:41 DEBUG : Yandex rclone-test-gitujax1gere: Waiting for transfers to finish
2025/06/21 02:22:44 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/06/21 02:22:44 INFO  : sub dir/hello world: Copied (server-side copy)
2025/06/21 02:22:48 DEBUG : Yandex rclone-test-gitujax1gere: Using server-side directory move
2025/06/21 02:22:49 INFO  : Yandex rclone-test-gitujax1gere: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/06/21 02:22:49 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11)
2025/06/21 02:22:49 DEBUG : Yandex rclone-test-gitujax1gere: Waiting for checks to finish
2025/06/21 02:22:49 DEBUG : Yandex rclone-test-gitujax1gere: Waiting for transfers to finish
2025/06/21 02:22:54 INFO  : sub dir/hello world: Deleted
2025/06/21 02:22:56 INFO  : sub dir/hello world: Moved (server-side)
2025/06/21 02:23:01 DEBUG : testing file moves
2025/06/21 02:23:02 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17)
2025/06/21 02:23:02 DEBUG : Yandex rclone-test-gitujax1gere: Waiting for checks to finish
2025/06/21 02:23:02 DEBUG : Yandex rclone-test-gitujax1gere: Waiting for transfers to finish
2025/06/21 02:23:06 INFO  : sub dir/hello world: Deleted
2025/06/21 02:23:08 INFO  : sub dir/hello world: Moved (server-side)
2025/06/21 02:23:10 DEBUG : Yandex rclone-test-gitujax1gere: Purge remote
--- PASS: TestServerSideMoveOverSelf (46.97s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFile
    run.go:180: Remote "Yandex rclone-test-jokados3duhi", Local "Local file system at /tmp/rclone1893486284", Modify Window "1ns"
2025/06/21 02:23:28 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:23:28 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/21 02:23:28 DEBUG : empty space: Unchanged skipping
2025/06/21 02:23:28 DEBUG : Yandex rclone-test-jokados3duhi: Waiting for checks to finish
2025/06/21 02:23:28 DEBUG : Yandex rclone-test-jokados3duhi: Waiting for transfers to finish
2025/06/21 02:23:30 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK
2025/06/21 02:23:30 INFO  : potato2: Copied (new)
2025/06/21 02:23:30 DEBUG : Waiting for deletions to finish
2025/06/21 02:23:34 INFO  : potato: Deleted
--- PASS: TestSyncAfterRemovingAFileAndAddingAFile (20.89s)
=== RUN   TestSyncDeleteBefore
    run.go:180: Remote "Yandex rclone-test-jokados3duhi", Local "Local file system at /tmp/rclone1893486284", Modify Window "1ns"
2025/06/21 02:23:49 DEBUG : Waiting for deletions to finish
2025/06/21 02:23:50 DEBUG : Yandex rclone-test-jokados3duhi: Waiting for checks to finish
2025/06/21 02:23:50 DEBUG : Yandex rclone-test-jokados3duhi: Waiting for transfers to finish
2025/06/21 02:23:54 INFO  : potato: Deleted
2025/06/21 02:23:55 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:23:55 DEBUG : potato2: Need to transfer - File not found at Destination
2025/06/21 02:23:55 DEBUG : Yandex rclone-test-jokados3duhi: Waiting for checks to finish
2025/06/21 02:23:55 DEBUG : empty space: Unchanged skipping
2025/06/21 02:23:55 DEBUG : Yandex rclone-test-jokados3duhi: Waiting for transfers to finish
2025/06/21 02:23:57 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK
2025/06/21 02:23:57 INFO  : potato2: Copied (new)
--- PASS: TestSyncDeleteBefore (23.01s)
=== RUN   TestSyncCompareDest
    run.go:180: Remote "Yandex rclone-test-jokados3duhi", Local "Local file system at /tmp/rclone1893486284", Modify Window "1ns"
2025/06/21 02:24:08 DEBUG : Creating backend with remote "TestYandex:rclone-test-jokados3duhi/dst"
2025/06/21 02:24:09 DEBUG : Creating backend with remote "TestYandex:rclone-test-jokados3duhi/CompareDest"
2025/06/21 02:24:10 DEBUG : one: Need to transfer - File not found at Destination
2025/06/21 02:24:10 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:24:10 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:24:12 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2025/06/21 02:24:12 INFO  : one: Copied (new)
2025/06/21 02:24:12 DEBUG : Waiting for deletions to finish
2025/06/21 02:24:14 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/21 02:24:14 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:24:14 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:24:16 DEBUG : one: Dst hash empty - aborting Src hash check
2025/06/21 02:24:16 INFO  : one: Copied (replaced existing)
2025/06/21 02:24:16 DEBUG : Waiting for deletions to finish
2025/06/21 02:24:22 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/21 02:24:22 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:24:22 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:24:22 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/21 02:24:22 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:24:22 DEBUG : Waiting for deletions to finish
2025/06/21 02:24:22 INFO  : There was nothing to transfer
2025/06/21 02:24:26 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/21 02:24:26 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:24:26 DEBUG : two: Destination found in --compare-dest, skipping
2025/06/21 02:24:26 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:24:26 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:24:26 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/21 02:24:26 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:24:26 DEBUG : Waiting for deletions to finish
2025/06/21 02:24:26 INFO  : There was nothing to transfer
2025/06/21 02:24:27 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/21 02:24:28 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:24:28 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/21 02:24:28 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:24:28 DEBUG : two: Destination found in --compare-dest, skipping
2025/06/21 02:24:28 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:24:28 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:24:28 DEBUG : Waiting for deletions to finish
2025/06/21 02:24:28 INFO  : There was nothing to transfer
2025/06/21 02:24:29 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/21 02:24:30 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:24:30 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/21 02:24:30 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
2025/06/21 02:24:30 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2025/06/21 02:24:30 DEBUG : two: Destination found in --compare-dest, skipping
2025/06/21 02:24:30 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:24:30 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:24:30 DEBUG : Waiting for deletions to finish
2025/06/21 02:24:30 INFO  : There was nothing to transfer
2025/06/21 02:24:31 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/21 02:24:32 DEBUG : two: Sizes differ (src 5 vs dst 3)
2025/06/21 02:24:32 DEBUG : two: Need to transfer - File not found at Destination
2025/06/21 02:24:32 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:24:32 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:24:32 DEBUG : one: Destination found in --compare-dest, skipping
2025/06/21 02:24:32 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:24:34 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK
2025/06/21 02:24:34 INFO  : two: Copied (new)
2025/06/21 02:24:34 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCompareDest (57.28s)
=== RUN   TestSyncCopyDest
    run.go:180: Remote "Yandex rclone-test-jokados3duhi", Local "Local file system at /tmp/rclone1893486284", Modify Window "1ns"
2025/06/21 02:25:05 DEBUG : Creating backend with remote "TestYandex:rclone-test-jokados3duhi/dst"
2025/06/21 02:25:06 DEBUG : Creating backend with remote "TestYandex:rclone-test-jokados3duhi/CopyDest"
2025/06/21 02:25:07 DEBUG : one: Need to transfer - File not found at Destination
2025/06/21 02:25:07 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:25:07 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:25:09 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2025/06/21 02:25:09 INFO  : one: Copied (new)
2025/06/21 02:25:09 DEBUG : Waiting for deletions to finish
2025/06/21 02:25:11 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/21 02:25:11 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:25:11 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:25:13 DEBUG : one: Dst hash empty - aborting Src hash check
2025/06/21 02:25:13 INFO  : one: Copied (replaced existing)
2025/06/21 02:25:13 DEBUG : Waiting for deletions to finish
2025/06/21 02:25:19 DEBUG : Creating backend with remote "TestYandex:rclone-test-jokados3duhi/BackupDir"
2025/06/21 02:25:20 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/21 02:25:20 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:25:20 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:25:20 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/06/21 02:25:22 INFO  : one: Moved (server-side)
2025/06/21 02:25:24 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2025/06/21 02:25:24 INFO  : one: Copied (server-side copy)
2025/06/21 02:25:24 DEBUG : one: Destination found in --copy-dest, using server-side copy
2025/06/21 02:25:24 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:25:24 DEBUG : Waiting for deletions to finish
2025/06/21 02:25:27 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:25:27 DEBUG : one: Unchanged skipping
2025/06/21 02:25:27 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:25:29 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2025/06/21 02:25:29 INFO  : two: Copied (server-side copy)
2025/06/21 02:25:29 DEBUG : two: Destination found in --copy-dest, using server-side copy
2025/06/21 02:25:29 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:25:29 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:25:29 DEBUG : Waiting for deletions to finish
2025/06/21 02:25:30 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:25:30 DEBUG : one: Unchanged skipping
2025/06/21 02:25:30 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:25:30 DEBUG : two: Unchanged skipping
2025/06/21 02:25:30 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:25:30 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:25:30 DEBUG : Waiting for deletions to finish
2025/06/21 02:25:30 INFO  : There was nothing to transfer
2025/06/21 02:25:34 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:25:34 DEBUG : one: Unchanged skipping
2025/06/21 02:25:34 DEBUG : three: Sizes differ (src 7 vs dst 5)
2025/06/21 02:25:34 DEBUG : three: Destination not found in --copy-dest
2025/06/21 02:25:34 DEBUG : three: Need to transfer - File not found at Destination
2025/06/21 02:25:34 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:25:34 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:25:34 DEBUG : two: Unchanged skipping
2025/06/21 02:25:34 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:25:36 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK
2025/06/21 02:25:36 INFO  : three: Copied (new)
2025/06/21 02:25:36 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncCopyDest (84.51s)
=== RUN   TestSyncBackupDir
    run.go:180: Remote "Yandex rclone-test-jokados3duhi", Local "Local file system at /tmp/rclone1893486284", Modify Window "1ns"
2025/06/21 02:26:37 DEBUG : Creating backend with remote "TestYandex:rclone-test-jokados3duhi/dst"
2025/06/21 02:26:37 DEBUG : Creating backend with remote "TestYandex:rclone-test-jokados3duhi/backup"
2025/06/21 02:26:38 DEBUG : one: Sizes differ (src 4 vs dst 3)
2025/06/21 02:26:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:26:38 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:26:38 DEBUG : two: Unchanged skipping
2025/06/21 02:26:39 INFO  : one: Moved (server-side)
2025/06/21 02:26:39 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:26:41 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK
2025/06/21 02:26:41 INFO  : one: Copied (new)
2025/06/21 02:26:41 DEBUG : Waiting for deletions to finish
2025/06/21 02:26:43 INFO  : three.txt: Moved (server-side)
2025/06/21 02:26:43 INFO  : three.txt: Moved into backup dir
2025/06/21 02:26:47 DEBUG : one: Sizes differ (src 5 vs dst 4)
2025/06/21 02:26:47 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for checks to finish
2025/06/21 02:26:47 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns)
2025/06/21 02:26:47 DEBUG : two: Unchanged skipping
2025/06/21 02:26:51 INFO  : one: Deleted
2025/06/21 02:26:53 INFO  : one: Moved (server-side)
2025/06/21 02:26:53 DEBUG : Yandex rclone-test-jokados3duhi/dst: Waiting for transfers to finish
2025/06/21 02:26:55 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK
2025/06/21 02:26:55 INFO  : one: Copied (new)
2025/06/21 02:26:55 DEBUG : Waiting for deletions to finish
2025/06/21 02:27:00 INFO  : three.txt: Deleted
2025/06/21 02:27:01 INFO  : three.txt: Moved (server-side)
2025/06/21 02:27:01 INFO  : three.txt: Moved into backup dir
--- PASS: TestSyncBackupDir (61.01s)
=== RUN   TestNothingToTransferWithoutEmptyDirs
    run.go:180: Remote "Yandex rclone-test-jokados3duhi", Local "Local file system at /tmp/rclone1893486284", Modify Window "1ns"
2025/06/21 02:27:31 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/06/21 02:27:31 INFO  : sub dir: Making directory
2025/06/21 02:27:31 INFO  : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC
--- PASS: TestNothingToTransferWithoutEmptyDirs (84.07s)
PASS
2025/06/21 02:28:55 DEBUG : Yandex rclone-test-jokados3duhi: Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestNothingToTransferWithoutEmptyDirs|TestServerSideMoveOverSelf|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncBackupDir|TestSyncCompareDest|TestSyncCopyDest|TestSyncDeleteBefore)$'" - Finished OK in 6m22.985513622s (try 2/5)