"./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestServerSideMove|TestSyncAfterChangingModtimeOnly|TestSyncWithExcludeAndDeleteExcluded|TestSyncWithUpdateOlder)$'" - Starting (try 2/5)
2026/02/13 05:31:10 DEBUG : Creating backend with remote "TestYandex:rclone-test-qujahiw1giha"
2026/02/13 05:31:10 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/13 05:31:11 DEBUG : Creating backend with remote "/tmp/rclone2616952630"
=== RUN   TestSyncAfterChangingModtimeOnly
    run.go:185: Remote "Yandex rclone-test-qujahiw1giha", Local "Local file system at /tmp/rclone2616952630", Modify Window "1ns"
2026/02/13 05:31:13 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for checks to finish
2026/02/13 05:31:13 DEBUG : empty space: size = 1 OK
2026/02/13 05:31:13 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC
2026/02/13 05:31:13 DEBUG : empty space: md5 = 336d5ebc5436534e61d16e63ddfca327 OK
2026/02/13 05:31:13 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1)
2026/02/13 05:31:13 DEBUG : empty space: Unchanged skipping
2026/02/13 05:31:13 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for transfers to finish
2026/02/13 05:31:13 DEBUG : Waiting for deletions to finish
2026/02/13 05:31:13 INFO  : There was nothing to transfer
2026/02/13 05:31:14 DEBUG : empty space: size = 1 OK
2026/02/13 05:31:14 DEBUG : empty space: Modification times differ by -95456h54m52.62345679s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06.499999999 +0000 UTC
2026/02/13 05:31:14 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for checks to finish
2026/02/13 05:31:14 DEBUG : empty space: md5 = 336d5ebc5436534e61d16e63ddfca327 OK
2026/02/13 05:31:14 INFO  : empty space: Updated modification time in destination
2026/02/13 05:31:14 DEBUG : empty space: Unchanged skipping
2026/02/13 05:31:14 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for transfers to finish
2026/02/13 05:31:14 DEBUG : Waiting for deletions to finish
2026/02/13 05:31:14 INFO  : There was nothing to transfer
--- PASS: TestSyncAfterChangingModtimeOnly (9.90s)
=== RUN   TestSyncWithExcludeAndDeleteExcluded
    run.go:185: Remote "Yandex rclone-test-qujahiw1giha", Local "Local file system at /tmp/rclone2616952630", Modify Window "1ns"
2026/02/13 05:31:27 DEBUG : enormous: Excluded (Size Filter)
2026/02/13 05:31:27 DEBUG : enormous: Excluded
2026/02/13 05:31:27 DEBUG : potato2: Excluded (Size Filter)
2026/02/13 05:31:27 DEBUG : potato2: Excluded
2026/02/13 05:31:27 DEBUG : empty space: size = 1 OK
2026/02/13 05:31:27 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for checks to finish
2026/02/13 05:31:27 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2026/02/13 05:31:27 DEBUG : empty space: Unchanged skipping
2026/02/13 05:31:27 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for transfers to finish
2026/02/13 05:31:27 DEBUG : Waiting for deletions to finish
2026/02/13 05:31:32 INFO  : potato2: Deleted
2026/02/13 05:31:32 INFO  : enormous: Deleted
2026/02/13 05:31:32 INFO  : There was nothing to transfer
2026/02/13 05:31:33 DEBUG : empty space: size = 1 OK
2026/02/13 05:31:33 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2026/02/13 05:31:33 DEBUG : empty space: Unchanged skipping
2026/02/13 05:31:33 DEBUG : Local file system at /tmp/rclone2616952630: Waiting for checks to finish
2026/02/13 05:31:33 DEBUG : Local file system at /tmp/rclone2616952630: Waiting for transfers to finish
2026/02/13 05:31:33 DEBUG : Waiting for deletions to finish
2026/02/13 05:31:33 INFO  : potato2: Deleted
2026/02/13 05:31:33 INFO  : enormous: Deleted
2026/02/13 05:31:33 INFO  : There was nothing to transfer
--- PASS: TestSyncWithExcludeAndDeleteExcluded (18.93s)
=== RUN   TestSyncWithUpdateOlder
    run.go:185: Remote "Yandex rclone-test-qujahiw1giha", Local "Local file system at /tmp/rclone2616952630", Modify Window "1ns"
2026/02/13 05:31:47 DEBUG : five: Need to transfer - File not found at Destination
2026/02/13 05:31:47 DEBUG : four: size = 4 (Local file system at /tmp/rclone2616952630)
2026/02/13 05:31:47 DEBUG : four: size = 8 (Yandex rclone-test-qujahiw1giha)
2026/02/13 05:31:47 DEBUG : four: Sizes differ
2026/02/13 05:31:47 DEBUG : three: size = 5 OK
2026/02/13 05:31:47 DEBUG : three: Sizes identical
2026/02/13 05:31:47 DEBUG : two: size = 3 OK
2026/02/13 05:31:47 DEBUG : one: Destination is newer than source, skipping
2026/02/13 05:31:47 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for checks to finish
2026/02/13 05:31:47 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 (Local file system at /tmp/rclone2616952630)
2026/02/13 05:31:47 DEBUG : two: md5 = 0f82d86afa0f5dc965c5c15aca58dcfb (Yandex rclone-test-qujahiw1giha)
2026/02/13 05:31:47 DEBUG : two: md5 differ
2026/02/13 05:31:47 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring
2026/02/13 05:31:47 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping
2026/02/13 05:31:47 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for transfers to finish
2026/02/13 05:31:49 DEBUG : four: size = 4 OK
2026/02/13 05:31:49 DEBUG : four: Dst hash empty - aborting Src hash check
2026/02/13 05:31:49 INFO  : four: Copied (replaced existing)
2026/02/13 05:31:49 DEBUG : two: size = 3 OK
2026/02/13 05:31:49 DEBUG : two: Dst hash empty - aborting Src hash check
2026/02/13 05:31:49 INFO  : two: Copied (replaced existing)
2026/02/13 05:31:50 DEBUG : five: size = 4 OK
2026/02/13 05:31:50 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK
2026/02/13 05:31:50 INFO  : five: Copied (new)
2026/02/13 05:31:50 DEBUG : Waiting for deletions to finish
2026/02/13 05:31:50 DEBUG : four: size = 4 OK
2026/02/13 05:31:50 DEBUG : five: size = 4 OK
2026/02/13 05:31:50 DEBUG : three: size = 5 OK
2026/02/13 05:31:50 DEBUG : one: Destination is newer than source, skipping
2026/02/13 05:31:50 DEBUG : two: size = 3 OK
2026/02/13 05:31:50 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for checks to finish
2026/02/13 05:31:50 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK
2026/02/13 05:31:50 DEBUG : three: md5 = 35d6d33467aae9a2e3dccb4b6b027878 (Local file system at /tmp/rclone2616952630)
2026/02/13 05:31:50 DEBUG : four: Size and md5 of src and dst objects identical
2026/02/13 05:31:50 DEBUG : three: md5 = 413af0de1f97a2155acf2b8b26ab36e2 (Yandex rclone-test-qujahiw1giha)
2026/02/13 05:31:50 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping
2026/02/13 05:31:50 DEBUG : three: md5 differ
2026/02/13 05:31:50 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring
2026/02/13 05:31:50 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2026/02/13 05:31:50 DEBUG : two: Size and md5 of src and dst objects identical
2026/02/13 05:31:50 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK
2026/02/13 05:31:50 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping
2026/02/13 05:31:50 DEBUG : five: Size and md5 of src and dst objects identical
2026/02/13 05:31:50 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping
2026/02/13 05:31:50 DEBUG : Yandex rclone-test-qujahiw1giha: Waiting for transfers to finish
2026/02/13 05:31:52 DEBUG : three: size = 5 OK
2026/02/13 05:31:52 DEBUG : three: Dst hash empty - aborting Src hash check
2026/02/13 05:31:52 INFO  : three: Copied (replaced existing)
2026/02/13 05:31:52 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithUpdateOlder (39.67s)
=== RUN   TestServerSideMove
    run.go:185: Remote "Yandex rclone-test-qujahiw1giha", Local "Local file system at /tmp/rclone2616952630", Modify Window "1ns"
2026/02/13 05:32:19 DEBUG : Creating backend with remote "TestYandex:rclone-test-hefotow4life"
    sync_test.go:1736: Server side move (if possible) Yandex rclone-test-qujahiw1giha -> Yandex rclone-test-hefotow4life
2026/02/13 05:32:29 DEBUG : Yandex rclone-test-hefotow4life: Using server-side directory move
2026/02/13 05:32:29 INFO  : Yandex rclone-test-hefotow4life: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2026/02/13 05:32:29 DEBUG : potato2: Need to transfer - File not found at Destination
2026/02/13 05:32:29 DEBUG : empty space: size = 1 OK
2026/02/13 05:32:29 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2026/02/13 05:32:29 DEBUG : empty space: Unchanged skipping
2026/02/13 05:32:29 DEBUG : potato3: size = 68 (Yandex rclone-test-qujahiw1giha)
2026/02/13 05:32:29 DEBUG : potato3: size = 60 (Yandex rclone-test-hefotow4life)
2026/02/13 05:32:29 DEBUG : potato3: Sizes differ
2026/02/13 05:32:29 DEBUG : Yandex rclone-test-hefotow4life: Waiting for checks to finish
2026/02/13 05:32:31 INFO  : potato2: Moved (server-side)
2026/02/13 05:32:34 INFO  : potato3: Deleted
2026/02/13 05:32:35 INFO  : empty space: Deleted
2026/02/13 05:32:35 DEBUG : Yandex rclone-test-hefotow4life: Waiting for transfers to finish
2026/02/13 05:32:36 INFO  : potato3: Moved (server-side)
2026/02/13 05:32:37 DEBUG : Creating backend with remote "TestYandex:rclone-test-maveger5coxi"
2026/02/13 05:32:37 DEBUG : Yandex rclone-test-maveger5coxi: Using server-side directory move
2026/02/13 05:32:39 INFO  : Yandex rclone-test-maveger5coxi: Server side directory move succeeded
2026/02/13 05:32:39 ERROR : error listing: directory not found
2026/02/13 05:32:39 DEBUG : Yandex rclone-test-maveger5coxi: Purge remote
2026/02/13 05:32:53 DEBUG : Yandex rclone-test-hefotow4life: Purge remote
2026/02/13 05:32:54 NOTICE: purge failed: [404 - DiskNotFoundError] Resource not found. (Не удалось найти запрошенный ресурс.)
--- PASS: TestServerSideMove (34.99s)
PASS
2026/02/13 05:32:54 DEBUG : Yandex rclone-test-qujahiw1giha: Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestServerSideMove|TestSyncAfterChangingModtimeOnly|TestSyncWithExcludeAndDeleteExcluded|TestSyncWithUpdateOlder)$'" - Finished OK in 1m50.058078474s (try 2/5)