"./vfs.test -test.v -test.timeout 1h0m0s -remote TestMega: -verbose" - Starting (try 3/5)
2026/06/22 03:20:43 DEBUG : Creating backend with remote "TestMega:rclone-test-wezamal3vuse"
2026/06/22 03:20:43 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/06/22 03:20:43 DEBUG : mega root 'rclone-test-wezamal3vuse': Using previously stored session ID and master key to initialize the Mega API
2026/06/22 03:21:21 DEBUG : Creating backend with remote "/tmp/rclone1105138996"
=== RUN   TestDirHandleMethods
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:21:21 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:21:21 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
    run.go:255: Failed to mkdir "mega root 'rclone-test-wezamal3vuse'": mkdir create node failed: unexpected end of JSON input
2026/06/22 03:21:31 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:21:31 DEBUG : Looking for writers
2026/06/22 03:21:31 DEBUG : >WaitForWriters: 
2026/06/22 03:21:31 ERROR : error listing: directory not found
--- FAIL: TestDirHandleMethods (10.58s)
=== RUN   TestDirHandleReaddir
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:21:31 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:21:31 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:21:38 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:21:38 DEBUG : dir/subdir: Looking for writers
2026/06/22 03:21:38 DEBUG : dir: Looking for writers
2026/06/22 03:21:38 DEBUG : subdir: reading active writers
2026/06/22 03:21:38 DEBUG : file1: reading active writers
2026/06/22 03:21:38 DEBUG : file2: reading active writers
2026/06/22 03:21:38 DEBUG : Looking for writers
2026/06/22 03:21:38 DEBUG : dir: reading active writers
2026/06/22 03:21:38 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleReaddir (7.47s)
=== RUN   TestDirHandleReaddirnames
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:21:39 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:21:39 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:21:39 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:21:39 DEBUG : dir: Looking for writers
2026/06/22 03:21:39 DEBUG : file1: reading active writers
2026/06/22 03:21:39 DEBUG : Looking for writers
2026/06/22 03:21:39 DEBUG : dir: reading active writers
2026/06/22 03:21:39 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleReaddirnames (0.87s)
=== RUN   TestDirMethods
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:21:40 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:21:40 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:21:40 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:21:40 DEBUG : dir: Looking for writers
2026/06/22 03:21:40 DEBUG : Looking for writers
2026/06/22 03:21:40 DEBUG : dir: reading active writers
2026/06/22 03:21:40 DEBUG : >WaitForWriters: 
    run.go:186: removing dir "dir" failed - try 1/3: sleeping 1s: directory not empty
--- PASS: TestDirMethods (1.98s)
=== RUN   TestDirForgetAll
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:21:42 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:21:42 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:21:42 DEBUG : dir: forgetting directory cache
2026/06/22 03:21:42 DEBUG : forgetting directory cache
2026/06/22 03:21:42 DEBUG : dir: forgetting directory cache
2026/06/22 03:21:42 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:21:42 DEBUG : Looking for writers
2026/06/22 03:21:42 DEBUG : >WaitForWriters: 
    run.go:186: removing dir "dir" failed - try 1/3: sleeping 1s: directory not empty
--- PASS: TestDirForgetAll (1.59s)
=== RUN   TestDirForgetPath
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:21:43 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:21:43 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:21:44 DEBUG : ForgetPath: relativePath="dir/notfound", type=1
2026/06/22 03:21:44 DEBUG : dir: invalidating directory cache
2026/06/22 03:21:44 DEBUG : >ForgetPath: 
2026/06/22 03:21:44 DEBUG : ForgetPath: relativePath="dir", type=0
2026/06/22 03:21:44 DEBUG : invalidating directory cache
2026/06/22 03:21:44 DEBUG : dir: forgetting directory cache
2026/06/22 03:21:44 DEBUG : >ForgetPath: 
2026/06/22 03:21:44 DEBUG : ForgetPath: relativePath="not/in/cache", type=0
2026/06/22 03:21:44 DEBUG : >ForgetPath: 
2026/06/22 03:21:44 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:21:44 DEBUG : dir: Looking for writers
2026/06/22 03:21:44 DEBUG : Looking for writers
2026/06/22 03:21:44 DEBUG : dir: reading active writers
2026/06/22 03:21:44 DEBUG : >WaitForWriters: 
    run.go:186: removing dir "dir" failed - try 1/3: sleeping 1s: directory not empty
--- PASS: TestDirForgetPath (1.75s)
=== RUN   TestDirWalk
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:21:45 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:21:45 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
    run.go:303: Failed to put "dir/file1" to "mega root 'rclone-test-wezamal3vuse'": upload file failed to create session: unexpected end of JSON input
2026/06/22 03:21:56 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:21:56 DEBUG : Looking for writers
2026/06/22 03:21:56 DEBUG : >WaitForWriters: 
--- FAIL: TestDirWalk (21.75s)
=== RUN   TestDirSetModTime
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:22:07 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:22:07 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:22:10 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:22:10 DEBUG : dir: Looking for writers
2026/06/22 03:22:10 DEBUG : Looking for writers
2026/06/22 03:22:10 DEBUG : dir: reading active writers
2026/06/22 03:22:10 DEBUG : >WaitForWriters: 
    run.go:186: removing dir "dir" failed - try 1/3: sleeping 1s: directory not empty
--- PASS: TestDirSetModTime (4.29s)
=== RUN   TestDirStat
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:22:11 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:22:11 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:22:12 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:22:12 DEBUG : dir: Looking for writers
2026/06/22 03:22:12 DEBUG : file1: reading active writers
2026/06/22 03:22:12 DEBUG : Looking for writers
2026/06/22 03:22:12 DEBUG : dir: reading active writers
2026/06/22 03:22:12 DEBUG : >WaitForWriters: 
--- PASS: TestDirStat (0.84s)
=== RUN   TestDirReadDirAll
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:22:12 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:22:12 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
=== RUN   TestDirReadDirAll/Virtual
2026/06/22 03:22:13 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile"
2026/06/22 03:22:13 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir"
2026/06/22 03:22:13 DEBUG : dir: Added virtual directory entry vDel: "file2"
2026/06/22 03:22:13 DEBUG : dir: Added virtual directory entry vDel: "subdir"
2026/06/22 03:22:14 DEBUG : dir: invalidating directory cache
2026/06/22 03:22:14 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir"
2026/06/22 03:22:14 DEBUG : dir: Removed virtual directory entry vDel: "file2"
2026/06/22 03:22:14 DEBUG : dir: Removed virtual directory entry vDel: "subdir"
2026/06/22 03:22:14 DEBUG : dir/file1: Reset virtual modtime
2026/06/22 03:22:14 DEBUG : dir: Removed virtual directory entry vAddFile: "virtualFile"
2026/06/22 03:22:14 DEBUG : dir/virtualFile: Reset virtual modtime
2026/06/22 03:22:14 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile2"
2026/06/22 03:22:14 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir2"
2026/06/22 03:22:14 DEBUG : dir: Added virtual directory entry vDel: "file1"
2026/06/22 03:22:14 DEBUG : dir: invalidating directory cache
2026/06/22 03:22:14 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir2"
2026/06/22 03:22:14 DEBUG : dir: Removed virtual directory entry vDel: "file1"
2026/06/22 03:22:14 DEBUG : dir/virtualFile: Reset virtual modtime
2026/06/22 03:22:14 DEBUG : forgetting directory cache
2026/06/22 03:22:14 DEBUG : dir: forgetting directory cache
2026/06/22 03:22:14 DEBUG : dir/virtualDir: forgetting directory cache
2026/06/22 03:22:14 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:22:14 DEBUG : dir/virtualDir: Looking for writers
2026/06/22 03:22:14 DEBUG : dir: Looking for writers
2026/06/22 03:22:14 DEBUG : file1: reading active writers
2026/06/22 03:22:14 DEBUG : virtualFile2: reading active writers
2026/06/22 03:22:14 DEBUG : virtualFile: reading active writers
2026/06/22 03:22:14 DEBUG : virtualDir: reading active writers
2026/06/22 03:22:14 DEBUG : Looking for writers
2026/06/22 03:22:14 DEBUG : dir: reading active writers
2026/06/22 03:22:14 DEBUG : >WaitForWriters: 
--- PASS: TestDirReadDirAll (2.92s)
    --- PASS: TestDirReadDirAll/Virtual (1.12s)
=== RUN   TestDirOpen
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:22:15 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:22:15 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:22:15 ERROR : dir/: Can only open directories read only
2026/06/22 03:22:15 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:22:15 DEBUG : dir: Looking for writers
2026/06/22 03:22:15 DEBUG : Looking for writers
2026/06/22 03:22:15 DEBUG : dir: reading active writers
2026/06/22 03:22:15 DEBUG : >WaitForWriters: 
    run.go:186: removing dir "dir" failed - try 1/3: sleeping 1s: directory not empty
--- PASS: TestDirOpen (1.64s)
=== RUN   TestDirCreate
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:22:17 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:22:17 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:22:17 DEBUG : dir/potato: Open: flags=O_WRONLY|O_CREATE
2026/06/22 03:22:17 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2026/06/22 03:22:17 DEBUG : dir/potato: >Open: fd=dir/potato (w), err=<nil>
2026/06/22 03:22:17 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2026/06/22 03:22:17 DEBUG : mega root 'rclone-test-wezamal3vuse': File to upload is small (5 bytes), uploading instead of streaming
2026/06/22 03:22:17 DEBUG : dir/potato: size = 5 OK
2026/06/22 03:22:17 NOTICE: mega root 'rclone-test-wezamal3vuse': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only
2026/06/22 03:22:17 DEBUG : dir/potato: Size of src and dst objects identical
2026/06/22 03:22:17 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2026/06/22 03:22:17 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:22:17 DEBUG : dir: Looking for writers
2026/06/22 03:22:17 DEBUG : file1: reading active writers
2026/06/22 03:22:17 DEBUG : potato: reading active writers
2026/06/22 03:22:17 DEBUG : Looking for writers
2026/06/22 03:22:17 DEBUG : dir: reading active writers
2026/06/22 03:22:17 DEBUG : >WaitForWriters: 
    run.go:186: removing dir "dir" failed - try 1/3: sleeping 1s: directory not empty
--- PASS: TestDirCreate (2.11s)
=== RUN   TestDirMkdir
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:22:19 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:22:19 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:22:19 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2026/06/22 03:22:19 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:22:19 DEBUG : dir/sub: Looking for writers
2026/06/22 03:22:19 DEBUG : dir: Looking for writers
2026/06/22 03:22:19 DEBUG : file1: reading active writers
2026/06/22 03:22:19 DEBUG : sub: reading active writers
2026/06/22 03:22:19 DEBUG : Looking for writers
2026/06/22 03:22:19 DEBUG : dir: reading active writers
2026/06/22 03:22:19 DEBUG : >WaitForWriters: 
--- PASS: TestDirMkdir (1.07s)
=== RUN   TestDirMkdirSub
    run.go:198: Remote "mega root 'rclone-test-wezamal3vuse'", Local "Local file system at /tmp/rclone1105138996", Modify Window "876000h0m0s"
2026/06/22 03:22:20 INFO  : mega root 'rclone-test-wezamal3vuse': poll-interval is not supported by this remote
2026/06/22 03:22:20 NOTICE: mega root 'rclone-test-wezamal3vuse': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2026/06/22 03:22:31 ERROR : dir/: Dir.Mkdir failed to create directory: Mkdir failed: mkdir create node failed: unexpected end of JSON input
    dir_test.go:419: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:419
        	Error:      	Received unexpected error:
        	            	Mkdir failed: mkdir create node failed: unexpected end of JSON input
        	Test:       	TestDirMkdirSub
2026/06/22 03:22:31 DEBUG : WaitForWriters: timeout=30s
2026/06/22 03:22:31 DEBUG : dir: Looking for writers
2026/06/22 03:22:31 DEBUG : file1: reading active writers
2026/06/22 03:22:31 DEBUG : Looking for writers
2026/06/22 03:22:31 DEBUG : dir: reading active writers
2026/06/22 03:22:31 DEBUG : >WaitForWriters: 
--- FAIL: TestDirMkdirSub (28.20s)
panic: runtime error: invalid memory address or nil pointer dereference [recovered, repanicked]
[signal SIGSEGV: segmentation violation code=0x1 addr=0x0 pc=0xb6f782]

goroutine 565 [running]:
testing.tRunner.func1.2({0x2572200, 0x46bb7d0})
	/usr/local/go/src/testing/testing.go:1974 +0x232
testing.tRunner.func1()
	/usr/local/go/src/testing/testing.go:1977 +0x349
panic({0x2572200?, 0x46bb7d0?})
	/usr/local/go/src/runtime/panic.go:860 +0x13a
github.com/rclone/rclone/vfs.(*Dir).Mkdir(0x2c38640?, {0x2a800fa?, 0x2c38ae0?})
	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir.go:1067 +0x22
github.com/rclone/rclone/vfs.TestDirMkdirSub(0x8ea13ee6908)
	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:421 +0x14b
testing.tRunner(0x8ea13ee6908, 0x2c1db90)
	/usr/local/go/src/testing/testing.go:2036 +0xea
created by testing.(*T).Run in goroutine 1
	/usr/local/go/src/testing/testing.go:2101 +0x4c5
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestMega: -verbose" - Finished ERROR in 2m5.10566889s (try 3/5): exit status 2: Failed [TestDirHandleMethods TestDirWalk TestDirMkdirSub]