"./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestServerSideMoveOverSelf|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncConcurrentDelete|TestSyncWithTrackRenamesStrategyLeaf)$'" - Starting (try 2/5) 2025/11/10 04:38:56 DEBUG : Creating backend with remote "TestYandex:rclone-test-jicubip0womo" 2025/11/10 04:38:56 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/10 04:38:56 DEBUG : Creating backend with remote "/tmp/rclone2870638085" === RUN TestServerSideMoveOverSelf run.go:185: Remote "Yandex rclone-test-jicubip0womo", Local "Local file system at /tmp/rclone2870638085", Modify Window "1ns" 2025/11/10 04:38:59 DEBUG : Creating backend with remote "TestYandex:rclone-test-qaxihal7nowo" sync_test.go:701: Server side copy (if possible) Yandex rclone-test-jicubip0womo -> Yandex rclone-test-qaxihal7nowo 2025/11/10 04:39:00 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/11/10 04:39:00 DEBUG : Yandex rclone-test-qaxihal7nowo: Waiting for checks to finish 2025/11/10 04:39:00 DEBUG : Yandex rclone-test-qaxihal7nowo: Waiting for transfers to finish 2025/11/10 04:39:03 DEBUG : sub dir/hello world: size = 11 OK 2025/11/10 04:39:03 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/11/10 04:39:03 INFO : sub dir/hello world: Copied (server-side copy) 2025/11/10 04:39:07 DEBUG : Yandex rclone-test-qaxihal7nowo: Using server-side directory move 2025/11/10 04:39:07 INFO : Yandex rclone-test-qaxihal7nowo: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/11/10 04:39:08 DEBUG : sub dir/hello world: size = 17 (Yandex rclone-test-jicubip0womo) 2025/11/10 04:39:08 DEBUG : sub dir/hello world: size = 11 (Yandex rclone-test-qaxihal7nowo) 2025/11/10 04:39:08 DEBUG : sub dir/hello world: Sizes differ 2025/11/10 04:39:08 DEBUG : Yandex rclone-test-qaxihal7nowo: Waiting for checks to finish 2025/11/10 04:39:08 DEBUG : Yandex rclone-test-qaxihal7nowo: Waiting for transfers to finish 2025/11/10 04:39:13 INFO : sub dir/hello world: Deleted 2025/11/10 04:39:14 INFO : sub dir/hello world: Moved (server-side) 2025/11/10 04:39:18 DEBUG : testing file moves 2025/11/10 04:39:19 DEBUG : Yandex rclone-test-qaxihal7nowo: Waiting for checks to finish 2025/11/10 04:39:19 DEBUG : sub dir/hello world: size = 24 (Yandex rclone-test-jicubip0womo) 2025/11/10 04:39:19 DEBUG : sub dir/hello world: size = 17 (Yandex rclone-test-qaxihal7nowo) 2025/11/10 04:39:19 DEBUG : sub dir/hello world: Sizes differ 2025/11/10 04:39:19 DEBUG : Yandex rclone-test-qaxihal7nowo: Waiting for transfers to finish 2025/11/10 04:39:24 INFO : sub dir/hello world: Deleted 2025/11/10 04:39:26 INFO : sub dir/hello world: Moved (server-side) 2025/11/10 04:39:28 DEBUG : Yandex rclone-test-qaxihal7nowo: Purge remote --- PASS: TestServerSideMoveOverSelf (48.83s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:185: Remote "Yandex rclone-test-jicubip0womo", Local "Local file system at /tmp/rclone2870638085", Modify Window "1ns" 2025/11/10 04:39:49 INFO : d: Making directory 2025/11/10 04:39:49 INFO : d/e: Making directory 2025/11/10 04:39:51 DEBUG : a/potato2: Need to transfer - File not found at Destination 2025/11/10 04:39:51 DEBUG : c/non empty space: size = 5 OK 2025/11/10 04:39:51 DEBUG : c/non empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:39:51 DEBUG : c/non empty space: Unchanged skipping 2025/11/10 04:39:51 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for checks to finish 2025/11/10 04:39:51 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for transfers to finish 2025/11/10 04:39:53 DEBUG : a/potato2: size = 60 OK 2025/11/10 04:39:53 DEBUG : a/potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK 2025/11/10 04:39:53 INFO : a/potato2: Copied (new) 2025/11/10 04:39:53 DEBUG : Waiting for deletions to finish 2025/11/10 04:39:58 INFO : b/potato: Deleted 2025/11/10 04:39:58 INFO : d/e: Removing directory 2025/11/10 04:40:04 INFO : d: Removing directory 2025/11/10 04:40:11 INFO : b: Removing directory 2025/11/10 04:40:17 DEBUG : Yandex rclone-test-jicubip0womo: deleted 3 directories --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (55.63s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:185: Remote "Yandex rclone-test-jicubip0womo", Local "Local file system at /tmp/rclone2870638085", Modify Window "1ns" sync_test.go:1679: Can track renames: true 2025/11/10 04:40:41 INFO : Yandex rclone-test-jicubip0womo: Making map for --track-renames 2025/11/10 04:40:41 INFO : Yandex rclone-test-jicubip0womo: Finished making map for --track-renames 2025/11/10 04:40:41 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for checks to finish 2025/11/10 04:40:41 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/11/10 04:40:41 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for renames to finish 2025/11/10 04:40:41 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/11/10 04:40:41 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for transfers to finish 2025/11/10 04:40:43 DEBUG : sub/yam: size = 11 OK 2025/11/10 04:40:43 DEBUG : sub/yam: md5 = 48dc443644c4b89556dc06834b46451d OK 2025/11/10 04:40:43 INFO : sub/yam: Copied (new) 2025/11/10 04:40:44 DEBUG : potato: size = 14 OK 2025/11/10 04:40:44 DEBUG : potato: md5 = 7f6fa9ddec9bfebda9510af0323fd696 OK 2025/11/10 04:40:44 INFO : potato: Copied (new) 2025/11/10 04:40:44 DEBUG : Waiting for deletions to finish 2025/11/10 04:40:45 DEBUG : potato: size = 14 OK 2025/11/10 04:40:45 DEBUG : potato: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:40:45 DEBUG : potato: Unchanged skipping 2025/11/10 04:40:46 INFO : Yandex rclone-test-jicubip0womo: Making map for --track-renames 2025/11/10 04:40:46 INFO : Yandex rclone-test-jicubip0womo: Finished making map for --track-renames 2025/11/10 04:40:46 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for checks to finish 2025/11/10 04:40:46 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for renames to finish 2025/11/10 04:40:48 INFO : sub/yam: Moved (server-side) to: yam 2025/11/10 04:40:48 INFO : yam: Renamed from "sub/yam" 2025/11/10 04:40:48 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for transfers to finish 2025/11/10 04:40:48 DEBUG : Waiting for deletions to finish 2025/11/10 04:40:48 INFO : There was nothing to transfer --- PASS: TestSyncWithTrackRenamesStrategyLeaf (25.57s) === RUN TestSyncConcurrentDelete run.go:185: Remote "Yandex rclone-test-jicubip0womo", Local "Local file system at /tmp/rclone2870638085", Modify Window "1ns" fstest.go:127: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:132 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:151 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2774 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2788 Error: Should be true Test: TestSyncConcurrentDelete Messages: only19: Modification time difference too big |-217104h37m22.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-11-10 04:42:29 +0000 UTC) (precision 1ns) fstest.go:127: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:132 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:151 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2774 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2788 Error: Should be true Test: TestSyncConcurrentDelete Messages: only9: Modification time difference too big |-217104h36m36.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-11-10 04:41:43 +0000 UTC) (precision 1ns) 2025/11/10 04:42:31 DEBUG : both0: size = 6 OK 2025/11/10 04:42:31 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both0: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both10: size = 6 OK 2025/11/10 04:42:31 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both10: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both11: size = 6 OK 2025/11/10 04:42:31 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both12: size = 6 OK 2025/11/10 04:42:31 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both13: size = 6 OK 2025/11/10 04:42:31 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both14: size = 6 OK 2025/11/10 04:42:31 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for checks to finish 2025/11/10 04:42:31 DEBUG : both11: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both15: size = 6 OK 2025/11/10 04:42:31 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both15: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both16: size = 6 OK 2025/11/10 04:42:31 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both16: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both17: size = 6 OK 2025/11/10 04:42:31 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both17: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both18: size = 6 OK 2025/11/10 04:42:31 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both18: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both19: size = 6 OK 2025/11/10 04:42:31 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both19: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both1: size = 6 OK 2025/11/10 04:42:31 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both12: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both2: size = 6 OK 2025/11/10 04:42:31 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both13: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both3: size = 6 OK 2025/11/10 04:42:31 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both14: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both4: size = 6 OK 2025/11/10 04:42:31 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both4: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both5: size = 6 OK 2025/11/10 04:42:31 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both1: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both6: size = 6 OK 2025/11/10 04:42:31 DEBUG : both5: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both7: size = 6 OK 2025/11/10 04:42:31 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both6: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both8: size = 6 OK 2025/11/10 04:42:31 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both8: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both9: size = 6 OK 2025/11/10 04:42:31 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/11/10 04:42:31 DEBUG : both9: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both2: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both3: Unchanged skipping 2025/11/10 04:42:31 DEBUG : both7: Unchanged skipping 2025/11/10 04:42:31 DEBUG : Yandex rclone-test-jicubip0womo: Waiting for transfers to finish 2025/11/10 04:42:31 DEBUG : Waiting for deletions to finish 2025/11/10 04:42:36 INFO : only3: Deleted 2025/11/10 04:42:36 INFO : only1: Deleted 2025/11/10 04:42:37 INFO : only8: Deleted 2025/11/10 04:42:37 INFO : only4: Deleted 2025/11/10 04:42:41 INFO : only11: Deleted 2025/11/10 04:42:41 INFO : only15: Deleted 2025/11/10 04:42:42 INFO : only18: Deleted 2025/11/10 04:42:46 INFO : only19: Deleted 2025/11/10 04:42:46 INFO : only17: Deleted 2025/11/10 04:42:46 INFO : only6: Deleted 2025/11/10 04:42:47 INFO : only9: Deleted 2025/11/10 04:42:51 INFO : only12: Deleted 2025/11/10 04:42:52 INFO : only10: Deleted 2025/11/10 04:42:52 INFO : only2: Deleted 2025/11/10 04:42:52 INFO : only0: Deleted 2025/11/10 04:42:56 INFO : only5: Deleted 2025/11/10 04:42:57 INFO : only13: Deleted 2025/11/10 04:42:57 INFO : only14: Deleted 2025/11/10 04:42:58 INFO : only7: Deleted 2025/11/10 04:43:01 INFO : only16: Deleted 2025/11/10 04:43:01 INFO : There was nothing to transfer --- FAIL: TestSyncConcurrentDelete (219.76s) FAIL 2025/11/10 04:44:46 DEBUG : Yandex rclone-test-jicubip0womo: Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestServerSideMoveOverSelf|TestSyncAfterRemovingAFileAndAddingAFileSubDir|TestSyncConcurrentDelete|TestSyncWithTrackRenamesStrategyLeaf)$'" - Finished ERROR in 5m57.693532945s (try 2/5): exit status 1: Failed [TestSyncConcurrentDelete]