"./vfs.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestDirForgetAll|TestDirHandleMethods|TestDirReadDirAll|TestRcGetVFS|TestVFSNew|TestWriteFileHandleMethods)$'" - Starting (try 4/5) 2022/05/18 05:55:09 DEBUG : Creating backend with remote "TestHdfs:rclone-test-zijofez7tivifeh2lajefun8" 2022/05/18 05:55:09 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2022/05/18 05:55:09 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/18 05:55:09 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/18 05:55:09 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2022/05/18 05:55:09 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/18 05:55:09 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/18 05:55:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/05/18 05:55:09 DEBUG : Creating backend with remote "/tmp/rclone2733963556" === RUN TestDirHandleMethods run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2733963556", Modify Window "1s" 2022/05/18 05:55:09 INFO : hdfs://127.0.0.1:8020: poll-interval is not supported by this remote 2022/05/18 05:55:09 DEBUG : hdfs://127.0.0.1:8020: mkdir [/rclone-test-zijofez7tivifeh2lajefun8] 2022/05/18 05:55:09 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-zijofez7tivifeh2lajefun8/dir/file1] run.go:287: Failed to put "dir/file1" to "hdfs://127.0.0.1:8020": create /rclone-test-zijofez7tivifeh2lajefun8/dir/file1: replication in progress --- FAIL: TestDirHandleMethods (0.20s) === RUN TestDirForgetAll run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2733963556", Modify Window "1s" 2022/05/18 05:55:09 DEBUG : hdfs://127.0.0.1:8020: Re-using VFS from active cache 2022/05/18 05:55:09 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-zijofez7tivifeh2lajefun8/dir/file1] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8/dir] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8/dir] 2022/05/18 05:55:10 DEBUG : dir: forgetting directory cache 2022/05/18 05:55:10 DEBUG : : forgetting directory cache 2022/05/18 05:55:10 DEBUG : dir: forgetting directory cache 2022/05/18 05:55:10 DEBUG : WaitForWriters: timeout=30s 2022/05/18 05:55:10 DEBUG : : Looking for writers 2022/05/18 05:55:10 DEBUG : >WaitForWriters: 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8/dir] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-zijofez7tivifeh2lajefun8/dir/file1] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-zijofez7tivifeh2lajefun8/dir] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] --- PASS: TestDirForgetAll (0.05s) === RUN TestDirReadDirAll run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2733963556", Modify Window "1s" 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: Re-using VFS from active cache 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-zijofez7tivifeh2lajefun8/dir/file1] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-zijofez7tivifeh2lajefun8/dir/file2] run.go:287: Failed to put "dir/file2" to "hdfs://127.0.0.1:8020": create /rclone-test-zijofez7tivifeh2lajefun8/dir/file2: replication in progress 2022/05/18 05:55:10 DEBUG : WaitForWriters: timeout=30s 2022/05/18 05:55:10 DEBUG : : Looking for writers 2022/05/18 05:55:10 DEBUG : >WaitForWriters: 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8/dir] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-zijofez7tivifeh2lajefun8/dir/file1] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-zijofez7tivifeh2lajefun8/dir] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] --- FAIL: TestDirReadDirAll (0.05s) === RUN TestRcGetVFS rc_test.go:28: Error Trace: rc_test.go:28 Error: An error is expected but got nil. Test: TestRcGetVFS --- FAIL: TestRcGetVFS (0.00s) === RUN TestVFSNew vfs_test.go:134: Error Trace: vfs_test.go:134 vfs_test.go:137 Error: Not equal: expected: 0 actual : 1 Test: TestVFSNew run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2733963556", Modify Window "1s" 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: Re-using VFS from active cache 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: Re-using VFS from active cache 2022/05/18 05:55:10 DEBUG : WaitForWriters: timeout=30s 2022/05/18 05:55:10 DEBUG : : Looking for writers 2022/05/18 05:55:10 DEBUG : >WaitForWriters: 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] vfs_test.go:134: Error Trace: vfs_test.go:134 vfs_test.go:163 Error: Not equal: expected: 0 actual : 1 Test: TestVFSNew --- FAIL: TestVFSNew (0.00s) === RUN TestWriteFileHandleMethods run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2733963556", Modify Window "1s" 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: Re-using VFS from active cache 2022/05/18 05:55:10 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] 2022/05/18 05:55:10 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : file1: >Open: fd=file1 (w), err= 2022/05/18 05:55:10 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 ERROR : file1: WriteFileHandle: Read: Can't read and write to file without --vfs-cache-mode >= minimal 2022/05/18 05:55:10 ERROR : file1: WriteFileHandle: ReadAt: Can't read and write to file without --vfs-cache-mode >= minimal 2022/05/18 05:55:10 ERROR : file1: WriteFileHandle: Truncate: Can't change size without --vfs-cache-mode >= writes 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: File to upload is small (5 bytes), uploading instead of streaming 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-zijofez7tivifeh2lajefun8/file1] 2022/05/18 05:55:10 INFO : file1: Copied (new) 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] 2022/05/18 05:55:10 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2022/05/18 05:55:10 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : file1: >Open: fd=file1 (w), err= 2022/05/18 05:55:10 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2022/05/18 05:55:10 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2022/05/18 05:55:10 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : file1: >Open: fd=file1 (w), err= 2022/05/18 05:55:10 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2022/05/18 05:55:10 ERROR : file1: WriteFileHandle: Can't open for write without O_TRUNC on existing file without --vfs-cache-mode >= writes 2022/05/18 05:55:10 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE|O_TRUNC, perm=-rwxrwxrwx 2022/05/18 05:55:10 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE|O_TRUNC 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : file1: >Open: fd=file1 (w), err= 2022/05/18 05:55:10 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: File to upload is small (0 bytes), uploading instead of streaming 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-zijofez7tivifeh2lajefun8/file1] 2022/05/18 05:55:10 INFO : file1: Copied (new) 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE|O_TRUNC, perm=-rwxrwxrwx 2022/05/18 05:55:10 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE|O_TRUNC 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : file1: >Open: fd=file1 (w), err= 2022/05/18 05:55:10 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: File to upload is small (7 bytes), uploading instead of streaming 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-zijofez7tivifeh2lajefun8/file1] 2022/05/18 05:55:10 INFO : file1: Copied (new) 2022/05/18 05:55:10 DEBUG : : Added virtual directory entry vAddFile: "file1" 2022/05/18 05:55:10 DEBUG : WaitForWriters: timeout=30s 2022/05/18 05:55:10 DEBUG : : Looking for writers 2022/05/18 05:55:10 DEBUG : file1: reading active writers 2022/05/18 05:55:10 DEBUG : >WaitForWriters: 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-zijofez7tivifeh2lajefun8/file1] 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-zijofez7tivifeh2lajefun8] --- PASS: TestWriteFileHandleMethods (0.05s) FAIL 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: Purge remote 2022/05/18 05:55:10 DEBUG : hdfs://127.0.0.1:8020: purge [/rclone-test-zijofez7tivifeh2lajefun8] "./vfs.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestDirForgetAll|TestDirHandleMethods|TestDirReadDirAll|TestRcGetVFS|TestVFSNew|TestWriteFileHandleMethods)$'" - Finished ERROR in 475.469877ms (try 4/5): exit status 1: Failed [TestDirHandleMethods TestDirReadDirAll TestRcGetVFS TestVFSNew]