"./vfs.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose" - Starting (try 1/5)
2025/01/03 01:00:37 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gezodoh2fipo"
2025/01/03 01:00:37 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/03 01:00:37 DEBUG : proton drive root link ID 'rclone-test-gezodoh2fipo': Has cached credentials
2025/01/03 01:00:38 DEBUG : proton drive root link ID 'rclone-test-gezodoh2fipo': Used cached credential to initialize the ProtonDrive API
2025/01/03 01:00:38 DEBUG : Creating backend with remote "/tmp/rclone1020182023"
2025/01/03 01:00:38 DEBUG : Config file has changed externally - reloading
=== RUN   TestDirHandleMethods
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:00:38 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:00:38 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:00:42 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:00:42 DEBUG : dir: Looking for writers
2025/01/03 01:00:42 DEBUG : : Looking for writers
2025/01/03 01:00:42 DEBUG : dir: reading active writers
2025/01/03 01:00:42 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleMethods (5.34s)
=== RUN   TestDirHandleReaddir
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:00:44 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:00:44 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:00:51 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:00:51 DEBUG : dir/subdir: Looking for writers
2025/01/03 01:00:51 DEBUG : dir: Looking for writers
2025/01/03 01:00:51 DEBUG : file1: reading active writers
2025/01/03 01:00:51 DEBUG : file2: reading active writers
2025/01/03 01:00:51 DEBUG : subdir: reading active writers
2025/01/03 01:00:51 DEBUG : : Looking for writers
2025/01/03 01:00:51 DEBUG : dir: reading active writers
2025/01/03 01:00:51 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleReaddir (10.04s)
=== RUN   TestDirHandleReaddirnames
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:00:54 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:00:54 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:00:57 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:00:57 DEBUG : dir: Looking for writers
2025/01/03 01:00:57 DEBUG : file1: reading active writers
2025/01/03 01:00:57 DEBUG : : Looking for writers
2025/01/03 01:00:57 DEBUG : dir: reading active writers
2025/01/03 01:00:57 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleReaddirnames (4.60s)
=== RUN   TestDirMethods
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:00:58 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:00:58 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:01:01 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:01:01 DEBUG : dir: Looking for writers
2025/01/03 01:01:01 DEBUG : : Looking for writers
2025/01/03 01:01:01 DEBUG : dir: reading active writers
2025/01/03 01:01:01 DEBUG : >WaitForWriters: 
--- PASS: TestDirMethods (4.20s)
=== RUN   TestDirForgetAll
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:01:02 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:01:02 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:01:05 DEBUG : dir: forgetting directory cache
2025/01/03 01:01:05 DEBUG : : forgetting directory cache
2025/01/03 01:01:05 DEBUG : dir: forgetting directory cache
2025/01/03 01:01:05 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:01:05 DEBUG : : Looking for writers
2025/01/03 01:01:05 DEBUG : >WaitForWriters: 
--- PASS: TestDirForgetAll (4.50s)
=== RUN   TestDirForgetPath
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:01:07 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:01:07 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:01:10 DEBUG : : ForgetPath: relativePath="dir/notfound", type=1
2025/01/03 01:01:10 DEBUG : dir: invalidating directory cache
2025/01/03 01:01:10 DEBUG : : >ForgetPath: 
2025/01/03 01:01:10 DEBUG : : ForgetPath: relativePath="dir", type=0
2025/01/03 01:01:10 DEBUG : : invalidating directory cache
2025/01/03 01:01:10 DEBUG : dir: forgetting directory cache
2025/01/03 01:01:10 DEBUG : : >ForgetPath: 
2025/01/03 01:01:10 DEBUG : : ForgetPath: relativePath="not/in/cache", type=0
2025/01/03 01:01:10 DEBUG : : >ForgetPath: 
2025/01/03 01:01:10 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:01:10 DEBUG : dir: Looking for writers
2025/01/03 01:01:10 DEBUG : : Looking for writers
2025/01/03 01:01:10 DEBUG : dir: reading active writers
2025/01/03 01:01:10 DEBUG : >WaitForWriters: 
--- PASS: TestDirForgetPath (4.44s)
=== RUN   TestDirWalk
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:01:11 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:01:11 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:01:18 DEBUG : : forgetting directory cache
2025/01/03 01:01:18 DEBUG : dir: forgetting directory cache
2025/01/03 01:01:19 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:01:19 DEBUG : dir: Looking for writers
2025/01/03 01:01:19 DEBUG : fil/a/b: Looking for writers
2025/01/03 01:01:19 DEBUG : fil/a: Looking for writers
2025/01/03 01:01:19 DEBUG : b: reading active writers
2025/01/03 01:01:19 DEBUG : fil: Looking for writers
2025/01/03 01:01:19 DEBUG : a: reading active writers
2025/01/03 01:01:19 DEBUG : : Looking for writers
2025/01/03 01:01:19 DEBUG : dir: reading active writers
2025/01/03 01:01:19 DEBUG : fil: reading active writers
2025/01/03 01:01:19 DEBUG : >WaitForWriters: 
--- PASS: TestDirWalk (10.95s)
=== RUN   TestDirSetModTime
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:01:22 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:01:22 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:01:25 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:01:25 DEBUG : dir: Looking for writers
2025/01/03 01:01:25 DEBUG : : Looking for writers
2025/01/03 01:01:25 DEBUG : dir: reading active writers
2025/01/03 01:01:25 DEBUG : >WaitForWriters: 
--- PASS: TestDirSetModTime (4.32s)
=== RUN   TestDirStat
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:01:27 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:01:27 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:01:30 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:01:30 DEBUG : dir: Looking for writers
2025/01/03 01:01:30 DEBUG : file1: reading active writers
2025/01/03 01:01:30 DEBUG : : Looking for writers
2025/01/03 01:01:30 DEBUG : dir: reading active writers
2025/01/03 01:01:30 DEBUG : >WaitForWriters: 
--- PASS: TestDirStat (4.64s)
=== RUN   TestDirReadDirAll
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:01:31 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:01:31 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
=== RUN   TestDirReadDirAll/Virtual
2025/01/03 01:01:39 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile"
2025/01/03 01:01:39 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir"
2025/01/03 01:01:39 DEBUG : dir: Added virtual directory entry vDel: "file2"
2025/01/03 01:01:39 DEBUG : dir: Added virtual directory entry vDel: "subdir"
2025/01/03 01:01:43 DEBUG : dir: invalidating directory cache
2025/01/03 01:01:44 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir"
2025/01/03 01:01:44 DEBUG : dir: Removed virtual directory entry vDel: "file2"
2025/01/03 01:01:44 DEBUG : dir: Removed virtual directory entry vDel: "subdir"
2025/01/03 01:01:44 DEBUG : dir/file1: Reset virtual modtime
2025/01/03 01:01:44 DEBUG : dir: Removed virtual directory entry vAddFile: "virtualFile"
2025/01/03 01:01:44 DEBUG : dir/virtualFile: Reset virtual modtime
2025/01/03 01:01:44 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile2"
2025/01/03 01:01:44 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir2"
2025/01/03 01:01:44 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/01/03 01:01:44 DEBUG : dir: invalidating directory cache
2025/01/03 01:01:44 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir2"
2025/01/03 01:01:44 DEBUG : dir: Removed virtual directory entry vDel: "file1"
2025/01/03 01:01:44 DEBUG : dir/virtualFile: Reset virtual modtime
2025/01/03 01:01:44 DEBUG : : forgetting directory cache
2025/01/03 01:01:44 DEBUG : dir: forgetting directory cache
2025/01/03 01:01:44 DEBUG : dir/virtualDir: forgetting directory cache
2025/01/03 01:01:45 DEBUG : dir/file1: Reset virtual modtime
2025/01/03 01:01:45 DEBUG : dir/virtualFile: Reset virtual modtime
2025/01/03 01:01:45 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:01:45 DEBUG : dir/virtualDir: Looking for writers
2025/01/03 01:01:45 DEBUG : dir: Looking for writers
2025/01/03 01:01:45 DEBUG : file1: reading active writers
2025/01/03 01:01:45 DEBUG : virtualFile2: reading active writers
2025/01/03 01:01:45 DEBUG : virtualFile: reading active writers
2025/01/03 01:01:45 DEBUG : virtualDir: reading active writers
2025/01/03 01:01:45 DEBUG : : Looking for writers
2025/01/03 01:01:45 DEBUG : dir: reading active writers
2025/01/03 01:01:45 DEBUG : >WaitForWriters: 
--- PASS: TestDirReadDirAll (16.38s)
    --- PASS: TestDirReadDirAll/Virtual (5.87s)
=== RUN   TestDirOpen
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:01:48 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:01:48 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:01:50 ERROR : dir/: Can only open directories read only
2025/01/03 01:01:50 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:01:50 DEBUG : dir: Looking for writers
2025/01/03 01:01:50 DEBUG : : Looking for writers
2025/01/03 01:01:50 DEBUG : dir: reading active writers
2025/01/03 01:01:50 DEBUG : >WaitForWriters: 
--- PASS: TestDirOpen (4.37s)
=== RUN   TestDirCreate
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:01:52 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:01:52 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:01:55 DEBUG : dir/potato: Open: flags=O_WRONLY|O_CREATE
2025/01/03 01:01:55 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2025/01/03 01:01:55 DEBUG : dir/potato: >Open: fd=dir/potato (w), err=<nil>
2025/01/03 01:01:55 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2025/01/03 01:01:55 DEBUG : proton drive root link ID 'rclone-test-gezodoh2fipo': File to upload is small (5 bytes), uploading instead of streaming
2025/01/03 01:01:57 DEBUG : dir/potato: sha1 = aaf4c61ddcc5e8a2dabede0f3b482cd9aea9434d OK
2025/01/03 01:01:57 DEBUG : dir/potato: Size and sha1 of src and dst objects identical
2025/01/03 01:01:57 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2025/01/03 01:01:57 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:01:57 DEBUG : dir: Looking for writers
2025/01/03 01:01:57 DEBUG : file1: reading active writers
2025/01/03 01:01:57 DEBUG : potato: reading active writers
2025/01/03 01:01:57 DEBUG : : Looking for writers
2025/01/03 01:01:57 DEBUG : dir: reading active writers
2025/01/03 01:01:57 DEBUG : >WaitForWriters: 
--- PASS: TestDirCreate (6.74s)
=== RUN   TestDirMkdir
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:01:59 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:01:59 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:02:03 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2025/01/03 01:02:03 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:02:03 DEBUG : dir/sub: Looking for writers
2025/01/03 01:02:03 DEBUG : dir: Looking for writers
2025/01/03 01:02:03 DEBUG : file1: reading active writers
2025/01/03 01:02:03 DEBUG : sub: reading active writers
2025/01/03 01:02:03 DEBUG : : Looking for writers
2025/01/03 01:02:03 DEBUG : dir: reading active writers
2025/01/03 01:02:03 DEBUG : >WaitForWriters: 
--- PASS: TestDirMkdir (6.64s)
=== RUN   TestDirMkdirSub
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:02:05 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:02:05 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:02:09 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2025/01/03 01:02:10 DEBUG : dir/sub: Added virtual directory entry vAddDir: "subsub"
2025/01/03 01:02:11 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:02:11 DEBUG : dir/sub/subsub: Looking for writers
2025/01/03 01:02:11 DEBUG : dir/sub: Looking for writers
2025/01/03 01:02:11 DEBUG : subsub: reading active writers
2025/01/03 01:02:11 DEBUG : dir: Looking for writers
2025/01/03 01:02:11 DEBUG : file1: reading active writers
2025/01/03 01:02:11 DEBUG : sub: reading active writers
2025/01/03 01:02:11 DEBUG : : Looking for writers
2025/01/03 01:02:11 DEBUG : dir: reading active writers
2025/01/03 01:02:11 DEBUG : >WaitForWriters: 
--- PASS: TestDirMkdirSub (8.06s)
=== RUN   TestDirRemove
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:02:13 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:02:13 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:02:17 ERROR : dir/: Dir.Remove not empty
2025/01/03 01:02:17 DEBUG : dir/file1: Remove: 
2025/01/03 01:02:17 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/01/03 01:02:17 DEBUG : dir/file1: >Remove: err=<nil>
2025/01/03 01:02:17 DEBUG : : Added virtual directory entry vDel: "dir"
2025/01/03 01:02:18 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:02:18 DEBUG : : Looking for writers
2025/01/03 01:02:18 DEBUG : >WaitForWriters: 
--- PASS: TestDirRemove (4.48s)
=== RUN   TestDirRemoveAll
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:02:18 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:02:18 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:02:21 DEBUG : dir/file1: Remove: 
2025/01/03 01:02:22 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/01/03 01:02:22 DEBUG : dir/file1: >Remove: err=<nil>
2025/01/03 01:02:22 DEBUG : : Added virtual directory entry vDel: "dir"
2025/01/03 01:02:22 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:02:22 DEBUG : : Looking for writers
2025/01/03 01:02:22 DEBUG : >WaitForWriters: 
--- PASS: TestDirRemoveAll (4.62s)
=== RUN   TestDirRemoveName
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:02:23 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:02:23 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:02:26 DEBUG : dir/file1: Remove: 
2025/01/03 01:02:26 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/01/03 01:02:26 DEBUG : dir/file1: >Remove: err=<nil>
2025/01/03 01:02:27 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:02:27 DEBUG : dir: Looking for writers
2025/01/03 01:02:27 DEBUG : : Looking for writers
2025/01/03 01:02:27 DEBUG : dir: reading active writers
2025/01/03 01:02:27 DEBUG : >WaitForWriters: 
--- PASS: TestDirRemoveName (5.08s)
=== RUN   TestDirRename
    run.go:180: Remote "proton drive root link ID 'rclone-test-gezodoh2fipo'", Local "Local file system at /tmp/rclone1020182023", Modify Window "1s"
2025/01/03 01:02:28 INFO  : proton drive root link ID 'rclone-test-gezodoh2fipo': poll-interval is not supported by this remote
2025/01/03 01:02:28 NOTICE: proton drive root link ID 'rclone-test-gezodoh2fipo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/01/03 01:02:33 ERROR : dir/not found: Dir.Rename error: file does not exist
2025/01/03 01:02:33.865287 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XE1NKQGEgJcnr1xBx_hPM5omBg6W9HMd9bXhJH9PRY67UUsQuKiLYXO3YZsZm36UEn6GcfJBIDQFPAnAB5D4aQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1
2025/01/03 01:02:33.865563 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XE1NKQGEgJcnr1xBx_hPM5omBg6W9HMd9bXhJH9PRY67UUsQuKiLYXO3YZsZm36UEn6GcfJBIDQFPAnAB5D4aQ==/move: This value should not be blank. (Code=2000, Status=400)
2025/01/03 01:02:33 ERROR : dir: Dir.Rename error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XE1NKQGEgJcnr1xBx_hPM5omBg6W9HMd9bXhJH9PRY67UUsQuKiLYXO3YZsZm36UEn6GcfJBIDQFPAnAB5D4aQ==/move: This value should not be blank. (Code=2000, Status=400)
    dir_test.go:535: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:535
        	Error:      	Received unexpected error:
        	            	400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XE1NKQGEgJcnr1xBx_hPM5omBg6W9HMd9bXhJH9PRY67UUsQuKiLYXO3YZsZm36UEn6GcfJBIDQFPAnAB5D4aQ==/move: This value should not be blank. (Code=2000, Status=400)
        	Test:       	TestDirRename
    dir_test.go:247: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:247
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:536
        	Error:      	Not equal: 
        	            	expected: []string{"dir2,0,true"}
        	            	actual  : []string{"dir,0,true"}
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,3 +1,3 @@
        	            	 ([]string) (len=1) {
        	            	- (string) (len=11) "dir2,0,true"
        	            	+ (string) (len=10) "dir,0,true"
        	            	 }
        	Test:       	TestDirRename
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:295: Flushing the directory cache
    fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:295: Flushing the directory cache
    fstest.go:299: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299
        	            				/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:   	listing wrong, want
        	            	  dir2/file1 (14), dir2/file3 (15) got
        	            	  dir/file1 (14), dir/file3 (15)
    fstest.go:185: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185
        	            				/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:   	Unexpected file "dir/file1"
    fstest.go:185: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185
        	            				/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:   	Unexpected file "dir/file3"
    fstest.go:197: Not found "dir2/file1"
    fstest.go:197: Not found "dir2/file3"
    fstest.go:200: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304
        	            				/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:      	Not equal: 
        	            	expected: 0
        	            	actual  : 2
        	Test:       	TestDirRename
        	Messages:   	2 objects not found
    fstest.go:321: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:321
        	            				/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:      	Not equal: 
        	            	expected: []string{"dir2"}
        	            	actual  : []string{"dir"}
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,3 +1,3 @@
        	            	 ([]string) (len=1) {
        	            	- (string) (len=4) "dir2"
        	            	+ (string) (len=3) "dir"
        	            	 }
        	Test:       	TestDirRename
        	Messages:   	directories
    dir_test.go:546: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:546
        	Error:      	Received unexpected error:
        	            	file does not exist
        	Test:       	TestDirRename
2025/01/03 01:03:58 DEBUG : WaitForWriters: timeout=30s
2025/01/03 01:03:58 DEBUG : dir: Looking for writers
2025/01/03 01:03:58 DEBUG : file1: reading active writers
2025/01/03 01:03:58 DEBUG : file3: reading active writers
2025/01/03 01:03:58 DEBUG : : Looking for writers
2025/01/03 01:03:58 DEBUG : dir: reading active writers
2025/01/03 01:03:58 DEBUG : >WaitForWriters: 
--- FAIL: TestDirRename (379.70s)
panic: interface conversion: vfs.Node is nil, not *vfs.Dir [recovered]
	panic: interface conversion: vfs.Node is nil, not *vfs.Dir

goroutine 1631 [running]:
testing.tRunner.func1.2({0x206cf60, 0xc000776420})
	/usr/local/go/src/testing/testing.go:1631 +0x24a
testing.tRunner.func1()
	/usr/local/go/src/testing/testing.go:1634 +0x377
panic({0x206cf60?, 0xc000776420?})
	/usr/local/go/src/runtime/panic.go:770 +0x132
github.com/rclone/rclone/vfs.TestDirRename(0xc0000fd6c0)
	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:547 +0x110b
testing.tRunner(0xc0000fd6c0, 0x25dbe70)
	/usr/local/go/src/testing/testing.go:1689 +0xfb
created by testing.(*T).Run in goroutine 1
	/usr/local/go/src/testing/testing.go:1742 +0x390
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose" - Finished ERROR in 8m10.709993956s (try 1/5): exit status 2: Failed [TestDirRename]