"./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestCopyOverSelf|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestSyncWithUpdateOlder)$'" - Starting (try 2/5) 2025/10/19 02:47:08 DEBUG : Creating backend with remote "TestYandex:rclone-test-qoxetoh0qele" 2025/10/19 02:47:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/19 02:47:08 DEBUG : Creating backend with remote "/tmp/rclone2477902652" === RUN TestCopyOverSelf run.go:180: Remote "Yandex rclone-test-qoxetoh0qele", Local "Local file system at /tmp/rclone2477902652", Modify Window "1ns" 2025/10/19 02:47:12 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/10/19 02:47:12 DEBUG : Yandex rclone-test-qoxetoh0qele: Waiting for checks to finish 2025/10/19 02:47:12 DEBUG : Yandex rclone-test-qoxetoh0qele: Waiting for transfers to finish 2025/10/19 02:47:15 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check 2025/10/19 02:47:15 INFO : sub dir/hello world: Copied (replaced existing) --- PASS: TestCopyOverSelf (19.58s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "Yandex rclone-test-qoxetoh0qele", Local "Local file system at /tmp/rclone2477902652", Modify Window "1ns" 2025/10/19 02:47:38 DEBUG : five: Need to transfer - File not found at Destination 2025/10/19 02:47:38 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/10/19 02:47:38 DEBUG : three: Sizes identical 2025/10/19 02:47:38 DEBUG : one: Destination is newer than source, skipping 2025/10/19 02:47:38 DEBUG : Yandex rclone-test-qoxetoh0qele: Waiting for checks to finish 2025/10/19 02:47:38 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 (Local file system at /tmp/rclone2477902652) 2025/10/19 02:47:38 DEBUG : two: md5 = 0f82d86afa0f5dc965c5c15aca58dcfb (Yandex rclone-test-qoxetoh0qele) 2025/10/19 02:47:38 DEBUG : two: md5 differ 2025/10/19 02:47:38 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/10/19 02:47:38 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/10/19 02:47:38 DEBUG : Yandex rclone-test-qoxetoh0qele: Waiting for transfers to finish 2025/10/19 02:47:40 DEBUG : two: Dst hash empty - aborting Src hash check 2025/10/19 02:47:40 INFO : two: Copied (replaced existing) 2025/10/19 02:47:40 DEBUG : four: Dst hash empty - aborting Src hash check 2025/10/19 02:47:40 INFO : four: Copied (replaced existing) 2025/10/19 02:47:40 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK 2025/10/19 02:47:40 INFO : five: Copied (new) 2025/10/19 02:47:40 DEBUG : Waiting for deletions to finish 2025/10/19 02:47:41 DEBUG : Yandex rclone-test-qoxetoh0qele: Waiting for checks to finish 2025/10/19 02:47:41 DEBUG : one: Destination is newer than source, skipping 2025/10/19 02:47:41 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2025/10/19 02:47:41 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK 2025/10/19 02:47:41 DEBUG : four: Size and md5 of src and dst objects identical 2025/10/19 02:47:41 DEBUG : two: Size and md5 of src and dst objects identical 2025/10/19 02:47:41 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2025/10/19 02:47:41 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2025/10/19 02:47:41 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK 2025/10/19 02:47:41 DEBUG : five: Size and md5 of src and dst objects identical 2025/10/19 02:47:41 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2025/10/19 02:47:41 DEBUG : three: md5 = 35d6d33467aae9a2e3dccb4b6b027878 (Local file system at /tmp/rclone2477902652) 2025/10/19 02:47:41 DEBUG : three: md5 = 413af0de1f97a2155acf2b8b26ab36e2 (Yandex rclone-test-qoxetoh0qele) 2025/10/19 02:47:41 DEBUG : three: md5 differ 2025/10/19 02:47:41 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2025/10/19 02:47:41 DEBUG : Yandex rclone-test-qoxetoh0qele: Waiting for transfers to finish 2025/10/19 02:47:43 DEBUG : three: Dst hash empty - aborting Src hash check 2025/10/19 02:47:43 INFO : three: Copied (replaced existing) 2025/10/19 02:47:43 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (42.71s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Yandex rclone-test-qoxetoh0qele", Local "Local file system at /tmp/rclone2477902652", Modify Window "1ns" 2025/10/19 02:48:17 DEBUG : Creating backend with remote "TestYandex:rclone-test-qoxetoh0qele/dst" 2025/10/19 02:48:18 DEBUG : Creating backend with remote "TestYandex:rclone-test-qoxetoh0qele/backup" 2025/10/19 02:48:18 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/19 02:48:18 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/10/19 02:48:18 DEBUG : two: Unchanged skipping 2025/10/19 02:48:18 DEBUG : Yandex rclone-test-qoxetoh0qele/dst: Waiting for checks to finish 2025/10/19 02:48:20 INFO : one: Moved (server-side) to: one.bak 2025/10/19 02:48:20 DEBUG : Yandex rclone-test-qoxetoh0qele/dst: Waiting for transfers to finish 2025/10/19 02:48:22 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/10/19 02:48:22 INFO : one: Copied (new) 2025/10/19 02:48:22 DEBUG : Waiting for deletions to finish 2025/10/19 02:48:24 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/10/19 02:48:24 INFO : three.txt: Moved into backup dir 2025/10/19 02:48:27 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/10/19 02:48:27 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/10/19 02:48:27 DEBUG : two: Unchanged skipping 2025/10/19 02:48:27 DEBUG : Yandex rclone-test-qoxetoh0qele/dst: Waiting for checks to finish 2025/10/19 02:48:32 INFO : one.bak: Deleted 2025/10/19 02:48:34 INFO : one: Moved (server-side) to: one.bak 2025/10/19 02:48:34 DEBUG : Yandex rclone-test-qoxetoh0qele/dst: Waiting for transfers to finish 2025/10/19 02:48:37 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/10/19 02:48:37 INFO : one: Copied (new) 2025/10/19 02:48:37 DEBUG : Waiting for deletions to finish 2025/10/19 02:48:42 INFO : three.txt.bak: Deleted 2025/10/19 02:48:44 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/10/19 02:48:44 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (66.71s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Yandex rclone-test-qoxetoh0qele", Local "Local file system at /tmp/rclone2477902652", Modify Window "1ns" 2025/10/19 02:49:23 DEBUG : Creating backend with remote "TestYandex:rclone-test-qoxetoh0qele/dst" 2025/10/19 02:49:24 DEBUG : Creating backend with remote "TestYandex:rclone-test-qoxetoh0qele/backup" 2025/10/19 02:49:25 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/19 02:49:25 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/10/19 02:49:25 DEBUG : two: Unchanged skipping 2025/10/19 02:49:25 DEBUG : Yandex rclone-test-qoxetoh0qele/dst: Waiting for checks to finish 2025/10/19 02:49:26 INFO : one: Moved (server-side) to: one-2019-01-01 2025/10/19 02:49:26 DEBUG : Yandex rclone-test-qoxetoh0qele/dst: Waiting for transfers to finish 2025/10/19 02:49:29 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/10/19 02:49:29 INFO : one: Copied (new) 2025/10/19 02:49:29 DEBUG : Waiting for deletions to finish 2025/10/19 02:49:30 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/10/19 02:49:30 INFO : three.txt: Moved into backup dir 2025/10/19 02:49:34 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/10/19 02:49:34 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/10/19 02:49:34 DEBUG : two: Unchanged skipping 2025/10/19 02:49:34 DEBUG : Yandex rclone-test-qoxetoh0qele/dst: Waiting for checks to finish 2025/10/19 02:49:39 INFO : one-2019-01-01: Deleted 2025/10/19 02:49:41 INFO : one: Moved (server-side) to: one-2019-01-01 2025/10/19 02:49:41 DEBUG : Yandex rclone-test-qoxetoh0qele/dst: Waiting for transfers to finish 2025/10/19 02:49:43 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/10/19 02:49:43 INFO : one: Copied (new) 2025/10/19 02:49:43 DEBUG : Waiting for deletions to finish 2025/10/19 02:49:49 INFO : three-2019-01-01.txt: Deleted 2025/10/19 02:49:51 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/10/19 02:49:51 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (66.91s) === RUN TestSyncSuffix run.go:180: Remote "Yandex rclone-test-qoxetoh0qele", Local "Local file system at /tmp/rclone2477902652", Modify Window "1ns" 2025/10/19 02:50:31 DEBUG : Creating backend with remote "TestYandex:rclone-test-qoxetoh0qele/dst" 2025/10/19 02:50:32 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/19 02:50:33 INFO : one: Moved (server-side) to: one.bak 2025/10/19 02:50:36 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/10/19 02:50:36 INFO : one: Copied (new) 2025/10/19 02:50:36 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/10/19 02:50:36 DEBUG : two: Unchanged skipping 2025/10/19 02:50:37 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/10/19 02:50:39 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/10/19 02:50:41 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2025/10/19 02:50:41 INFO : three.txt: Copied (new) 2025/10/19 02:50:42 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/10/19 02:50:48 INFO : one.bak: Deleted 2025/10/19 02:50:50 INFO : one: Moved (server-side) to: one.bak 2025/10/19 02:50:52 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/10/19 02:50:52 INFO : one: Copied (new) 2025/10/19 02:50:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/10/19 02:50:52 DEBUG : two: Unchanged skipping 2025/10/19 02:50:52 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/10/19 02:50:58 INFO : three.txt.bak: Deleted 2025/10/19 02:50:59 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/10/19 02:51:01 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2025/10/19 02:51:01 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (69.81s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Yandex rclone-test-qoxetoh0qele", Local "Local file system at /tmp/rclone2477902652", Modify Window "1ns" 2025/10/19 02:51:34 DEBUG : empty_dir: Making directory with metadata 2025/10/19 02:51:34 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/10/19 02:51:34 DEBUG : empty_on_remote: Making directory with metadata 2025/10/19 02:51:34 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/10/19 02:51:34 INFO : empty_on_remote: Making directory 2025/10/19 02:51:34 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2025/10/19 02:51:39 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/10/19 02:51:39 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/10/19 02:51:39 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/10/19 02:51:39 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/10/19 02:51:39 INFO : empty_dir: Set directory modification time (using DirSetModTime) --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (54.23s) PASS 2025/10/19 02:52:28 DEBUG : Yandex rclone-test-qoxetoh0qele: Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestCopyOverSelf|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestSyncWithUpdateOlder)$'" - Finished OK in 5m26.674949467s (try 2/5)