"./vfs.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestDirEntryModTimeInvalidation|TestDirForgetPath|TestDirHandleReaddir|TestReadFileHandleRelease)$'" - Starting (try 2/5) 2025/02/16 04:14:51 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-natiyal8quza" 2025/02/16 04:14:51 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/02/16 04:14:51 DEBUG : Creating backend with remote "TestYandex:rclone-test-natiyal8quza" 2025/02/16 04:14:52 DEBUG : Reset feature "ListR" 2025/02/16 04:14:52 DEBUG : Creating backend with remote "/tmp/rclone1117560418" === RUN TestDirHandleReaddir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-natiyal8quza'", Local "Local file system at /tmp/rclone1117560418", Modify Window "1ns" 2025/02/16 04:14:52 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-natiyal8quza': poll-interval is not supported by this remote 2025/02/16 04:14:57 INFO : dir/file1.rclone_chunk.001_riq1ed: Moved (server-side) to: dir/file1 2025/02/16 04:15:01 INFO : dir/file2.rclone_chunk.001_riq6qj: Moved (server-side) to: dir/file2 2025/02/16 04:15:06 INFO : dir/subdir/file3.rclone_chunk.001_riqamf: Moved (server-side) to: dir/subdir/file3 2025/02/16 04:15:08 DEBUG : WaitForWriters: timeout=30s 2025/02/16 04:15:08 DEBUG : dir/subdir: Looking for writers 2025/02/16 04:15:08 DEBUG : dir: Looking for writers 2025/02/16 04:15:08 DEBUG : file1: reading active writers 2025/02/16 04:15:08 DEBUG : file2: reading active writers 2025/02/16 04:15:08 DEBUG : subdir: reading active writers 2025/02/16 04:15:08 DEBUG : : Looking for writers 2025/02/16 04:15:08 DEBUG : dir: reading active writers 2025/02/16 04:15:08 DEBUG : >WaitForWriters: --- PASS: TestDirHandleReaddir (36.72s) === RUN TestDirForgetPath run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-natiyal8quza'", Local "Local file system at /tmp/rclone1117560418", Modify Window "1ns" 2025/02/16 04:15:28 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-natiyal8quza': poll-interval is not supported by this remote 2025/02/16 04:15:34 INFO : dir/file1.rclone_chunk.001_rir2lt: Moved (server-side) to: dir/file1 2025/02/16 04:15:35 DEBUG : : ForgetPath: relativePath="dir/notfound", type=1 2025/02/16 04:15:35 DEBUG : dir: invalidating directory cache 2025/02/16 04:15:35 DEBUG : : >ForgetPath: 2025/02/16 04:15:35 DEBUG : : ForgetPath: relativePath="dir", type=0 2025/02/16 04:15:35 DEBUG : : invalidating directory cache 2025/02/16 04:15:35 DEBUG : dir: forgetting directory cache 2025/02/16 04:15:35 DEBUG : : >ForgetPath: 2025/02/16 04:15:35 DEBUG : : ForgetPath: relativePath="not/in/cache", type=0 2025/02/16 04:15:35 DEBUG : : >ForgetPath: 2025/02/16 04:15:35 DEBUG : WaitForWriters: timeout=30s 2025/02/16 04:15:35 DEBUG : dir: Looking for writers 2025/02/16 04:15:35 DEBUG : : Looking for writers 2025/02/16 04:15:35 DEBUG : dir: reading active writers 2025/02/16 04:15:35 DEBUG : >WaitForWriters: --- PASS: TestDirForgetPath (15.80s) === RUN TestDirEntryModTimeInvalidation run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-natiyal8quza'", Local "Local file system at /tmp/rclone1117560418", Modify Window "1ns" 2025/02/16 04:15:44 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-natiyal8quza': poll-interval is not supported by this remote 2025/02/16 04:15:50 INFO : dir/file1.rclone_chunk.001_rirhud: Moved (server-side) to: dir/file1 2025/02/16 04:15:51 DEBUG : : forgetting directory cache 2025/02/16 04:15:51 DEBUG : dir: forgetting directory cache 2025/02/16 04:15:51 DEBUG : dir: forgetting directory cache 2025/02/16 04:15:57 INFO : dir/file2.rclone_chunk.001_riro9o: Moved (server-side) to: dir/file2 dir_test.go:687: ModTime not invalidated 2025/02/16 04:15:57 DEBUG : WaitForWriters: timeout=30s 2025/02/16 04:15:57 DEBUG : dir: Looking for writers 2025/02/16 04:15:57 DEBUG : : Looking for writers 2025/02/16 04:15:57 DEBUG : dir: reading active writers 2025/02/16 04:15:57 DEBUG : >WaitForWriters: 2025/02/16 04:15:57 DEBUG : : forgetting directory cache 2025/02/16 04:15:57 DEBUG : dir: forgetting directory cache 2025/02/16 04:15:57 DEBUG : dir: forgetting directory cache --- FAIL: TestDirEntryModTimeInvalidation (24.86s) === RUN TestReadFileHandleRelease run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-natiyal8quza'", Local "Local file system at /tmp/rclone1117560418", Modify Window "1ns" 2025/02/16 04:16:09 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-natiyal8quza': poll-interval is not supported by this remote 2025/02/16 04:16:14 INFO : dir/file1.rclone_chunk.001_ris6hu: Moved (server-side) to: dir/file1 2025/02/16 04:16:19 DEBUG : dir/file1: OpenFile: flags=O_RDONLY, perm=-rwxrwxrwx 2025/02/16 04:16:20 DEBUG : dir/file1: Open: flags=O_RDONLY 2025/02/16 04:16:20 DEBUG : dir/file1: >Open: fd=dir/file1 (r), err= 2025/02/16 04:16:20 DEBUG : dir/file1: >OpenFile: fd=dir/file1 (r), err= 2025/02/16 04:16:20 DEBUG : dir/file1: ChunkedReader.openRange at 0 length 134217728 2025/02/16 04:16:20 DEBUG : dir/file1: ChunkedReader.Read at 0 length 256 chunkOffset 0 chunkSize 134217728 2025/02/16 04:16:20 DEBUG : dir/file1: ReadFileHandle.Release closing 2025/02/16 04:16:20 DEBUG : dir/file1: ReadFileHandle.Release nothing to do 2025/02/16 04:16:20 DEBUG : WaitForWriters: timeout=30s 2025/02/16 04:16:20 DEBUG : dir: Looking for writers 2025/02/16 04:16:20 DEBUG : file1: reading active writers 2025/02/16 04:16:20 DEBUG : : Looking for writers 2025/02/16 04:16:20 DEBUG : dir: reading active writers 2025/02/16 04:16:20 DEBUG : >WaitForWriters: --- PASS: TestReadFileHandleRelease (21.35s) FAIL 2025/02/16 04:16:30 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-natiyal8quza': Purge remote "./vfs.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestDirEntryModTimeInvalidation|TestDirForgetPath|TestDirHandleReaddir|TestReadFileHandleRelease)$'" - Finished ERROR in 1m42.827490822s (try 2/5): exit status 1: Failed [TestDirEntryModTimeInvalidation]