"./vfs.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestDirRemoveAll|TestDirRename)$'" - Starting (try 3/5) 2025/01/11 04:33:50 DEBUG : Creating backend with remote "TestYandex:rclone-test-lasuzex2rome" 2025/01/11 04:33:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/11 04:33:50 DEBUG : Creating backend with remote "/tmp/rclone2037195188" === RUN TestDirRemoveAll run.go:180: Remote "Yandex rclone-test-lasuzex2rome", Local "Local file system at /tmp/rclone2037195188", Modify Window "1ns" 2025/01/11 04:33:50 INFO : Yandex rclone-test-lasuzex2rome: poll-interval is not supported by this remote 2025/01/11 04:33:55 DEBUG : dir/file1: Remove: 2025/01/11 04:33:57 DEBUG : dir: Added virtual directory entry vDel: "file1" 2025/01/11 04:33:57 DEBUG : dir/file1: >Remove: err= 2025/01/11 04:33:59 DEBUG : : Added virtual directory entry vDel: "dir" 2025/01/11 04:34:00 DEBUG : WaitForWriters: timeout=30s 2025/01/11 04:34:00 DEBUG : : Looking for writers 2025/01/11 04:34:00 DEBUG : >WaitForWriters: --- PASS: TestDirRemoveAll (10.35s) === RUN TestDirRename run.go:180: Remote "Yandex rclone-test-lasuzex2rome", Local "Local file system at /tmp/rclone2037195188", Modify Window "1ns" 2025/01/11 04:34:01 INFO : Yandex rclone-test-lasuzex2rome: poll-interval is not supported by this remote fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:23 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:517 Error: Should be true Test: TestDirRename Messages: dir/file1: Modification time difference too big |-209832h28m56.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:34:03 +0000 UTC) (precision 1ns) fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:525 Error: Should be true Test: TestDirRename Messages: dir/file1: Modification time difference too big |-209832h28m56.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:34:03 +0000 UTC) (precision 1ns) 2025/01/11 04:34:09 ERROR : dir/not found: Dir.Rename error: file does not exist 2025/01/11 04:34:12 DEBUG : dir: Updating dir with dir2 0xc0000e4f70 2025/01/11 04:34:12 DEBUG : dir: forgetting directory cache 2025/01/11 04:34:12 DEBUG : : Added virtual directory entry vDel: "dir" 2025/01/11 04:34:12 DEBUG : : Added virtual directory entry vAddDir: "dir2" fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:542 Error: Should be true Test: TestDirRename Messages: dir2/file1: Modification time difference too big |-209832h28m56.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:34:03 +0000 UTC) (precision 1ns) 2025/01/11 04:34:15 INFO : dir2/file1: Moved (server-side) to: file2 2025/01/11 04:34:15 DEBUG : file2: Updating file with file2 0xc0005ee480 2025/01/11 04:34:15 DEBUG : dir2: Added virtual directory entry vDel: "file1" 2025/01/11 04:34:15 DEBUG : : Added virtual directory entry vAddFile: "file2" fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:560 Error: Should be true Test: TestDirRename Messages: file2: Modification time difference too big |-209832h29m7.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:34:14 +0000 UTC) (precision 1ns) 2025/01/11 04:34:18 INFO : dir2/file3: Deleted 2025/01/11 04:34:24 INFO : file2: Moved (server-side) to: dir2/file3 2025/01/11 04:34:24 DEBUG : dir2/file3: Updating file with dir2/file3 0xc0005ee480 2025/01/11 04:34:24 DEBUG : : Added virtual directory entry vDel: "file2" 2025/01/11 04:34:24 DEBUG : dir2: Added virtual directory entry vAddFile: "file3" fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:570 Error: Should be true Test: TestDirRename Messages: dir2/file3: Modification time difference too big |-209832h29m15.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:34:22 +0000 UTC) (precision 1ns) 2025/01/11 04:34:25 DEBUG : : Added virtual directory entry vAddDir: "empty directory" 2025/01/11 04:34:27 DEBUG : empty directory: Updating dir with renamed empty directory 0xc00073e340 2025/01/11 04:34:27 DEBUG : empty directory: forgetting directory cache 2025/01/11 04:34:27 DEBUG : : Added virtual directory entry vDel: "empty directory" 2025/01/11 04:34:27 DEBUG : : Added virtual directory entry vAddDir: "renamed empty directory" 2025/01/11 04:34:27 DEBUG : dir2: Renaming to "dir3" 2025/01/11 04:34:27 DEBUG : WaitForWriters: timeout=30s 2025/01/11 04:34:27 DEBUG : renamed empty directory: Looking for writers 2025/01/11 04:34:27 DEBUG : dir3: Looking for writers 2025/01/11 04:34:27 DEBUG : file3: reading active writers 2025/01/11 04:34:27 DEBUG : : Looking for writers 2025/01/11 04:34:27 DEBUG : dir3: reading active writers 2025/01/11 04:34:27 DEBUG : renamed empty directory: reading active writers 2025/01/11 04:34:27 DEBUG : >WaitForWriters: --- FAIL: TestDirRename (34.93s) FAIL 2025/01/11 04:34:36 DEBUG : Yandex rclone-test-lasuzex2rome: Purge remote "./vfs.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestDirRemoveAll|TestDirRename)$'" - Finished ERROR in 47.26212414s (try 3/5): exit status 1: Failed [TestDirRename]