"./vfs.test -test.v -test.timeout 2h0m0s -remote TestInternxt: -list-retries 5 -verbose -test.run '^(TestDirRename|TestWriteFileHandleMethods)$'" - Starting (try 3/5) 2026/08/29 03:36:07 DEBUG : Creating backend with remote "TestInternxt:rclone-test-geveyas4yeha" 2026/08/29 03:36:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/29 03:36:07 DEBUG : User info: rootFolderId=2661cf64-e104-478b-b737-48c3ac8984d2, bucket=697358bf16ceabcf39af85f2 2026/08/29 03:36:07 DEBUG : Saving config "token" in section "TestInternxt" of the config file 2026/08/29 03:36:07 DEBUG : TestInternxt: Saved new token in config file 2026/08/29 03:36:07 DEBUG : Internxt root 'rclone-test-geveyas4yeha': Persisted rotated token from user info, expiry: 2026-09-05 03:36:07 +0000 UTC 2026/08/29 03:36:08 DEBUG : Creating backend with remote "/tmp/rclone3199722884" === RUN TestDirRename run.go:198: Remote "Internxt root 'rclone-test-geveyas4yeha'", Local "Local file system at /tmp/rclone3199722884", Modify Window "876000h0m0s" 2026/08/29 03:36:08 INFO : Internxt root 'rclone-test-geveyas4yeha': poll-interval is not supported by this remote 2026/08/29 03:36:08 NOTICE: Internxt root 'rclone-test-geveyas4yeha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream FileLimitsResponse { "maxUploadFileSize": 107374182400, "versioning": { "enabled": true, "maxFileSize": 20971520, "retentionDays": 30, "maxVersions": 20 } } 2026/08/29 03:36:15 ERROR : dir/not found: Dir.Rename error: file does not exist 2026/08/29 03:36:16 DEBUG : dir: Updating dir with dir2 0xe8510924300 2026/08/29 03:36:16 DEBUG : dir: forgetting directory cache 2026/08/29 03:36:16 DEBUG : Added virtual directory entry vDel: "dir" 2026/08/29 03:36:16 DEBUG : Added virtual directory entry vAddDir: "dir2" 2026/08/29 03:36:18 INFO : dir2/file1: Moved (server-side) to: file2 2026/08/29 03:36:18 DEBUG : file2: Updating file with file2 0xe8510ab4270 2026/08/29 03:36:18 DEBUG : dir2: Added virtual directory entry vDel: "file1" 2026/08/29 03:36:18 DEBUG : Added virtual directory entry vAddFile: "file2" 2026/08/29 03:36:18 INFO : dir2/file3: Deleted 2026/08/29 03:36:19 INFO : file2: Moved (server-side) to: dir2/file3 2026/08/29 03:36:19 DEBUG : dir2/file3: Updating file with dir2/file3 0xe8510ab4270 2026/08/29 03:36:19 DEBUG : Added virtual directory entry vDel: "file2" 2026/08/29 03:36:19 DEBUG : dir2: Added virtual directory entry vAddFile: "file3" 2026/08/29 03:36:20 DEBUG : Added virtual directory entry vAddDir: "empty directory" 2026/08/29 03:36:21 DEBUG : empty directory: Updating dir with renamed empty directory 0xe8510d58000 2026/08/29 03:36:21 DEBUG : empty directory: forgetting directory cache 2026/08/29 03:36:21 DEBUG : Added virtual directory entry vDel: "empty directory" 2026/08/29 03:36:21 DEBUG : Added virtual directory entry vAddDir: "renamed empty directory" 2026/08/29 03:36:21 DEBUG : dir2: Renaming to "dir3" 2026/08/29 03:36:21 DEBUG : WaitForWriters: timeout=30s 2026/08/29 03:36:21 DEBUG : dir3: Looking for writers 2026/08/29 03:36:21 DEBUG : file3: reading active writers 2026/08/29 03:36:21 DEBUG : renamed empty directory: Looking for writers 2026/08/29 03:36:21 DEBUG : Looking for writers 2026/08/29 03:36:21 DEBUG : renamed empty directory: reading active writers 2026/08/29 03:36:21 DEBUG : dir3: reading active writers 2026/08/29 03:36:21 DEBUG : >WaitForWriters: 2026/08/29 03:36:21 ERROR : empty directory: error listing: directory not found --- PASS: TestDirRename (14.14s) === RUN TestWriteFileHandleMethods run.go:198: Remote "Internxt root 'rclone-test-geveyas4yeha'", Local "Local file system at /tmp/rclone3199722884", Modify Window "876000h0m0s" 2026/08/29 03:36:22 INFO : Internxt root 'rclone-test-geveyas4yeha': poll-interval is not supported by this remote 2026/08/29 03:36:22 NOTICE: Internxt root 'rclone-test-geveyas4yeha': --vfs-cache-mode writes or full is recommended for this remote as it can't stream 2026/08/29 03:36:22 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2026/08/29 03:36:22 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE 2026/08/29 03:36:22 DEBUG : Added virtual directory entry vAddFile: "file1" 2026/08/29 03:36:22 DEBUG : file1: >Open: fd=file1 (w), err= 2026/08/29 03:36:22 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2026/08/29 03:36:22 DEBUG : Added virtual directory entry vAddFile: "file1" 2026/08/29 03:36:22 ERROR : file1: WriteFileHandle: Read: Can't read and write to file without --vfs-cache-mode >= minimal 2026/08/29 03:36:22 ERROR : file1: WriteFileHandle: ReadAt: Can't read and write to file without --vfs-cache-mode >= minimal 2026/08/29 03:36:22 ERROR : file1: WriteFileHandle: Truncate: Can't change size without --vfs-cache-mode >= writes 2026/08/29 03:36:22 DEBUG : Internxt root 'rclone-test-geveyas4yeha': File to upload is small (5 bytes), uploading instead of streaming 2026/08/29 03:36:23 DEBUG : file1: size = 5 OK 2026/08/29 03:36:23 NOTICE: Internxt root 'rclone-test-geveyas4yeha': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2026/08/29 03:36:23 DEBUG : file1: Size of src and dst objects identical 2026/08/29 03:36:23 DEBUG : Added virtual directory entry vAddFile: "file1" dir_test.go:250: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250 /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:154 Error: Not equal: expected: []string{"file1,5,false"} actual : []string{"dir2,0,true", "file1,5,false", "renamed empty directory,0,true"} Diff: --- Expected +++ Actual @@ -1,3 +1,5 @@ -([]string) (len=1) { - (string) (len=13) "file1,5,false" +([]string) (len=3) { + (string) (len=11) "dir2,0,true", + (string) (len=13) "file1,5,false", + (string) (len=30) "renamed empty directory,0,true" } Test: TestWriteFileHandleMethods fstest.go:299: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/5 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/5 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 8s for list eventual consistency: 4/5 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 16s for list eventual consistency: 5/5 fstest.go:302: Flushing the directory cache fstest.go:328: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:328 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:158 Error: Not equal: expected: []string{} actual : []string{"dir2", "renamed empty directory"} Diff: --- Expected +++ Actual @@ -1,2 +1,4 @@ -([]string) { +([]string) (len=2) { + (string) (len=4) "dir2", + (string) (len=23) "renamed empty directory" } Test: TestWriteFileHandleMethods Messages: directories 2026/08/29 03:37:04 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2026/08/29 03:37:04 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE 2026/08/29 03:37:04 DEBUG : Added virtual directory entry vAddFile: "file1" 2026/08/29 03:37:04 DEBUG : file1: >Open: fd=file1 (w), err= 2026/08/29 03:37:04 DEBUG : file1: >OpenFile: fd=file1 (w), err= dir_test.go:250: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250 /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:165 Error: Not equal: expected: []string{"file1,5,false"} actual : []string{"dir2,0,true", "file1,5,false", "renamed empty directory,0,true"} Diff: --- Expected +++ Actual @@ -1,3 +1,5 @@ -([]string) (len=1) { - (string) (len=13) "file1,5,false" +([]string) (len=3) { + (string) (len=11) "dir2,0,true", + (string) (len=13) "file1,5,false", + (string) (len=30) "renamed empty directory,0,true" } Test: TestWriteFileHandleMethods 2026/08/29 03:37:04 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE, perm=-rwxrwxrwx 2026/08/29 03:37:04 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE 2026/08/29 03:37:04 DEBUG : Added virtual directory entry vAddFile: "file1" 2026/08/29 03:37:04 DEBUG : file1: >Open: fd=file1 (w), err= 2026/08/29 03:37:04 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2026/08/29 03:37:04 ERROR : file1: WriteFileHandle: Can't open for write without O_TRUNC on existing file without --vfs-cache-mode >= writes dir_test.go:250: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250 /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:174 Error: Not equal: expected: []string{"file1,5,false"} actual : []string{"dir2,0,true", "file1,5,false", "renamed empty directory,0,true"} Diff: --- Expected +++ Actual @@ -1,3 +1,5 @@ -([]string) (len=1) { - (string) (len=13) "file1,5,false" +([]string) (len=3) { + (string) (len=11) "dir2,0,true", + (string) (len=13) "file1,5,false", + (string) (len=30) "renamed empty directory,0,true" } Test: TestWriteFileHandleMethods 2026/08/29 03:37:04 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE|O_TRUNC, perm=-rwxrwxrwx 2026/08/29 03:37:04 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE|O_TRUNC 2026/08/29 03:37:04 DEBUG : Added virtual directory entry vAddFile: "file1" 2026/08/29 03:37:04 DEBUG : file1: >Open: fd=file1 (w), err= 2026/08/29 03:37:04 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2026/08/29 03:37:04 DEBUG : Added virtual directory entry vAddFile: "file1" 2026/08/29 03:37:04 DEBUG : Internxt root 'rclone-test-geveyas4yeha': File to upload is small (0 bytes), uploading instead of streaming 2026/08/29 03:37:06 DEBUG : Internxt root 'rclone-test-geveyas4yeha': Renamed existing file file1 to backup file1.rclone-backup-xitolad1. (UUID: 4e0dd07d-64ad-4d8b-ab83-8faf8ba0731b) 2026/08/29 03:37:06 DEBUG : Internxt root 'rclone-test-geveyas4yeha': Upload succeeded, deleting backup file file1.rclone-backup-xitolad1. (UUID: 4e0dd07d-64ad-4d8b-ab83-8faf8ba0731b) 2026/08/29 03:37:07 DEBUG : Internxt root 'rclone-test-geveyas4yeha': Successfully deleted backup file 2026/08/29 03:37:07 DEBUG : file1: size = 0 OK 2026/08/29 03:37:07 DEBUG : file1: Size of src and dst objects identical 2026/08/29 03:37:07 DEBUG : Added virtual directory entry vAddFile: "file1" dir_test.go:250: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250 /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:183 Error: Not equal: expected: []string{"file1,0,false"} actual : []string{"dir2,0,true", "file1,0,false", "renamed empty directory,0,true"} Diff: --- Expected +++ Actual @@ -1,3 +1,5 @@ -([]string) (len=1) { - (string) (len=13) "file1,0,false" +([]string) (len=3) { + (string) (len=11) "dir2,0,true", + (string) (len=13) "file1,0,false", + (string) (len=30) "renamed empty directory,0,true" } Test: TestWriteFileHandleMethods 2026/08/29 03:37:07 DEBUG : file1: OpenFile: flags=O_WRONLY|O_CREATE|O_TRUNC, perm=-rwxrwxrwx 2026/08/29 03:37:07 DEBUG : file1: Open: flags=O_WRONLY|O_CREATE|O_TRUNC 2026/08/29 03:37:07 DEBUG : Added virtual directory entry vAddFile: "file1" 2026/08/29 03:37:07 DEBUG : file1: >Open: fd=file1 (w), err= 2026/08/29 03:37:07 DEBUG : file1: >OpenFile: fd=file1 (w), err= 2026/08/29 03:37:07 DEBUG : Added virtual directory entry vAddFile: "file1" 2026/08/29 03:37:07 DEBUG : Internxt root 'rclone-test-geveyas4yeha': File to upload is small (7 bytes), uploading instead of streaming 2026/08/29 03:37:07 DEBUG : Internxt root 'rclone-test-geveyas4yeha': Renamed existing file file1 to backup file1.rclone-backup-qakepav1. (UUID: 9ce7b47d-b4b7-4ef3-b786-2743732217d5) 2026/08/29 03:37:08 DEBUG : Internxt root 'rclone-test-geveyas4yeha': Upload succeeded, deleting backup file file1.rclone-backup-qakepav1. (UUID: 9ce7b47d-b4b7-4ef3-b786-2743732217d5) 2026/08/29 03:37:08 DEBUG : Internxt root 'rclone-test-geveyas4yeha': Successfully deleted backup file 2026/08/29 03:37:08 DEBUG : file1: size = 7 OK 2026/08/29 03:37:08 DEBUG : file1: Size of src and dst objects identical 2026/08/29 03:37:08 DEBUG : Added virtual directory entry vAddFile: "file1" dir_test.go:250: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:250 /home/rclone/go/src/github.com/rclone/rclone/vfs/write_test.go:192 Error: Not equal: expected: []string{"file1,7,false"} actual : []string{"dir2,0,true", "file1,7,false", "renamed empty directory,0,true"} Diff: --- Expected +++ Actual @@ -1,3 +1,5 @@ -([]string) (len=1) { - (string) (len=13) "file1,7,false" +([]string) (len=3) { + (string) (len=11) "dir2,0,true", + (string) (len=13) "file1,7,false", + (string) (len=30) "renamed empty directory,0,true" } Test: TestWriteFileHandleMethods 2026/08/29 03:37:08 DEBUG : WaitForWriters: timeout=30s 2026/08/29 03:37:08 DEBUG : dir2: Looking for writers 2026/08/29 03:37:08 DEBUG : renamed empty directory: Looking for writers 2026/08/29 03:37:08 DEBUG : Looking for writers 2026/08/29 03:37:08 DEBUG : dir2: reading active writers 2026/08/29 03:37:08 DEBUG : renamed empty directory: reading active writers 2026/08/29 03:37:08 DEBUG : file1: reading active writers 2026/08/29 03:37:08 DEBUG : >WaitForWriters: 2026/08/29 03:37:10 ERROR : dir2: error listing: directory not found fstest.go:299: Sleeping for 1s for list eventual consistency: 1/5 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- FAIL: TestWriteFileHandleMethods (55.88s) FAIL 2026/08/29 03:37:19 DEBUG : Internxt root 'rclone-test-geveyas4yeha': Purge dir "" "./vfs.test -test.v -test.timeout 2h0m0s -remote TestInternxt: -list-retries 5 -verbose -test.run '^(TestDirRename|TestWriteFileHandleMethods)$'" - Finished ERROR in 1m12.585583426s (try 3/5): exit status 1: Failed [TestWriteFileHandleMethods]