"./vfs.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestDirRemoveAll|TestDirRename|TestFileOpenWrite)$'" - Starting (try 2/5) 2025/01/11 04:32:49 DEBUG : Creating backend with remote "TestYandex:rclone-test-heracot2mije" 2025/01/11 04:32:49 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/11 04:32:49 DEBUG : Creating backend with remote "/tmp/rclone387488118" === RUN TestDirRemoveAll run.go:180: Remote "Yandex rclone-test-heracot2mije", Local "Local file system at /tmp/rclone387488118", Modify Window "1ns" 2025/01/11 04:32:49 INFO : Yandex rclone-test-heracot2mije: 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:474 Error: Should be true Test: TestDirRemoveAll Messages: dir/file1: Modification time difference too big |-209832h27m44.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:32:51 +0000 UTC) (precision 1ns) 2025/01/11 04:32:54 DEBUG : dir/file1: Remove: 2025/01/11 04:32:56 DEBUG : dir: Added virtual directory entry vDel: "file1" 2025/01/11 04:32:56 DEBUG : dir/file1: >Remove: err= 2025/01/11 04:32:57 DEBUG : : Added virtual directory entry vDel: "dir" 2025/01/11 04:32:58 DEBUG : WaitForWriters: timeout=30s 2025/01/11 04:32:58 DEBUG : : Looking for writers 2025/01/11 04:32:58 DEBUG : >WaitForWriters: --- FAIL: TestDirRemoveAll (9.43s) === RUN TestDirRename run.go:180: Remote "Yandex rclone-test-heracot2mije", Local "Local file system at /tmp/rclone387488118", Modify Window "1ns" 2025/01/11 04:32:59 INFO : Yandex rclone-test-heracot2mije: 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 |-209832h27m53.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:33:00 +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 |-209832h27m53.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:33:00 +0000 UTC) (precision 1ns) 2025/01/11 04:33:07 ERROR : dir/not found: Dir.Rename error: file does not exist 2025/01/11 04:33:10 DEBUG : dir: Updating dir with dir2 0xc00089a820 2025/01/11 04:33:10 DEBUG : dir: forgetting directory cache 2025/01/11 04:33:10 DEBUG : : Added virtual directory entry vDel: "dir" 2025/01/11 04:33:10 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 |-209832h27m53.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:33:00 +0000 UTC) (precision 1ns) 2025/01/11 04:33:16 INFO : dir2/file1: Moved (server-side) to: file2 2025/01/11 04:33:16 DEBUG : file2: Updating file with file2 0xc0008ac780 2025/01/11 04:33:16 DEBUG : dir2: Added virtual directory entry vDel: "file1" 2025/01/11 04:33:16 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 |-209832h28m8.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:33:15 +0000 UTC) (precision 1ns) 2025/01/11 04:33:19 INFO : dir2/file3: Deleted 2025/01/11 04:33:20 INFO : file2: Moved (server-side) to: dir2/file3 2025/01/11 04:33:20 DEBUG : dir2/file3: Updating file with dir2/file3 0xc0008ac780 2025/01/11 04:33:20 DEBUG : : Added virtual directory entry vDel: "file2" 2025/01/11 04:33:20 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 |-209832h28m12.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-01-11 04:33:19 +0000 UTC) (precision 1ns) 2025/01/11 04:33:22 DEBUG : : Added virtual directory entry vAddDir: "empty directory" 2025/01/11 04:33:24 DEBUG : empty directory: Updating dir with renamed empty directory 0xc0000c88f0 2025/01/11 04:33:24 DEBUG : empty directory: forgetting directory cache 2025/01/11 04:33:24 DEBUG : : Added virtual directory entry vDel: "empty directory" 2025/01/11 04:33:24 DEBUG : : Added virtual directory entry vAddDir: "renamed empty directory" 2025/01/11 04:33:24 DEBUG : dir2: Renaming to "dir3" 2025/01/11 04:33:24 DEBUG : WaitForWriters: timeout=30s 2025/01/11 04:33:24 DEBUG : dir3: Looking for writers 2025/01/11 04:33:24 DEBUG : file3: reading active writers 2025/01/11 04:33:24 DEBUG : renamed empty directory: Looking for writers 2025/01/11 04:33:24 DEBUG : : Looking for writers 2025/01/11 04:33:24 DEBUG : renamed empty directory: reading active writers 2025/01/11 04:33:24 DEBUG : dir3: reading active writers 2025/01/11 04:33:24 DEBUG : >WaitForWriters: --- FAIL: TestDirRename (34.97s) === RUN TestFileOpenWrite run.go:180: Remote "Yandex rclone-test-heracot2mije", Local "Local file system at /tmp/rclone387488118", Modify Window "1ns" 2025/01/11 04:33:34 INFO : Yandex rclone-test-heracot2mije: poll-interval is not supported by this remote 2025/01/11 04:33:38 DEBUG : dir: Added virtual directory entry vAddFile: "file1" 2025/01/11 04:33:38 DEBUG : Yandex rclone-test-heracot2mije: File to upload is small (25 bytes), uploading instead of streaming 2025/01/11 04:33:43 DEBUG : dir/file1: md5 = c7247bead226dfd7bd970c17229f4044 OK 2025/01/11 04:33:43 DEBUG : dir/file1: Size and md5 of src and dst objects identical 2025/01/11 04:33:43 DEBUG : dir: Added virtual directory entry vAddFile: "file1" 2025/01/11 04:33:43 DEBUG : WaitForWriters: timeout=30s 2025/01/11 04:33:43 DEBUG : dir: Looking for writers 2025/01/11 04:33:43 DEBUG : file1: reading active writers 2025/01/11 04:33:43 DEBUG : : Looking for writers 2025/01/11 04:33:43 DEBUG : dir: reading active writers 2025/01/11 04:33:43 DEBUG : >WaitForWriters: --- PASS: TestFileOpenWrite (14.56s) FAIL 2025/01/11 04:33:48 DEBUG : Yandex rclone-test-heracot2mije: Purge remote "./vfs.test -test.v -test.timeout 1h0m0s -remote TestYandex: -verbose -test.run '^(TestDirRemoveAll|TestDirRename|TestFileOpenWrite)$'" - Finished ERROR in 1m1.479680574s (try 2/5): exit status 1: Failed [TestDirRemoveAll TestDirRename]