"./vfs.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose" - Starting (try 1/5)
2025/03/17 08:55:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rujaqif5yupo"
2025/03/17 08:55:02 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/17 08:55:02 DEBUG : proton drive root link ID 'rclone-test-rujaqif5yupo': Has cached credentials
2025/03/17 08:55:03 DEBUG : proton drive root link ID 'rclone-test-rujaqif5yupo': Used cached credential to initialize the ProtonDrive API
2025/03/17 08:55:03 DEBUG : Creating backend with remote "/tmp/rclone1438929192"
=== RUN   TestDirHandleMethods
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:55:03 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:55:03 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:55:07 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:55:07 DEBUG : dir: Looking for writers
2025/03/17 08:55:07 DEBUG : : Looking for writers
2025/03/17 08:55:07 DEBUG : dir: reading active writers
2025/03/17 08:55:07 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleMethods (5.81s)
=== RUN   TestDirHandleReaddir
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:55:09 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:55:09 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:55:17 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:55:17 DEBUG : dir/subdir: Looking for writers
2025/03/17 08:55:17 DEBUG : dir: Looking for writers
2025/03/17 08:55:17 DEBUG : file1: reading active writers
2025/03/17 08:55:17 DEBUG : file2: reading active writers
2025/03/17 08:55:17 DEBUG : subdir: reading active writers
2025/03/17 08:55:17 DEBUG : : Looking for writers
2025/03/17 08:55:17 DEBUG : dir: reading active writers
2025/03/17 08:55:17 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleReaddir (11.54s)
=== RUN   TestDirHandleReaddirnames
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:55:21 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:55:21 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:55:24 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:55:24 DEBUG : dir: Looking for writers
2025/03/17 08:55:24 DEBUG : file1: reading active writers
2025/03/17 08:55:24 DEBUG : : Looking for writers
2025/03/17 08:55:24 DEBUG : dir: reading active writers
2025/03/17 08:55:24 DEBUG : >WaitForWriters: 
--- PASS: TestDirHandleReaddirnames (5.42s)
=== RUN   TestDirMethods
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:55:26 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:55:26 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:55:29 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:55:29 DEBUG : dir: Looking for writers
2025/03/17 08:55:29 DEBUG : : Looking for writers
2025/03/17 08:55:29 DEBUG : dir: reading active writers
2025/03/17 08:55:29 DEBUG : >WaitForWriters: 
--- PASS: TestDirMethods (4.78s)
=== RUN   TestDirForgetAll
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:55:31 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:55:31 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:55:34 DEBUG : dir: forgetting directory cache
2025/03/17 08:55:34 DEBUG : : forgetting directory cache
2025/03/17 08:55:34 DEBUG : dir: forgetting directory cache
2025/03/17 08:55:34 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:55:34 DEBUG : : Looking for writers
2025/03/17 08:55:34 DEBUG : >WaitForWriters: 
--- PASS: TestDirForgetAll (4.35s)
=== RUN   TestDirForgetPath
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:55:35 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:55:35 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:55:38 DEBUG : : ForgetPath: relativePath="dir/notfound", type=1
2025/03/17 08:55:38 DEBUG : dir: invalidating directory cache
2025/03/17 08:55:38 DEBUG : : >ForgetPath: 
2025/03/17 08:55:38 DEBUG : : ForgetPath: relativePath="dir", type=0
2025/03/17 08:55:38 DEBUG : : invalidating directory cache
2025/03/17 08:55:38 DEBUG : dir: forgetting directory cache
2025/03/17 08:55:38 DEBUG : : >ForgetPath: 
2025/03/17 08:55:38 DEBUG : : ForgetPath: relativePath="not/in/cache", type=0
2025/03/17 08:55:38 DEBUG : : >ForgetPath: 
2025/03/17 08:55:38 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:55:38 DEBUG : dir: Looking for writers
2025/03/17 08:55:38 DEBUG : : Looking for writers
2025/03/17 08:55:38 DEBUG : dir: reading active writers
2025/03/17 08:55:38 DEBUG : >WaitForWriters: 
--- PASS: TestDirForgetPath (4.89s)
=== RUN   TestDirWalk
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:55:40 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:55:40 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:55:47 DEBUG : : forgetting directory cache
2025/03/17 08:55:47 DEBUG : dir: forgetting directory cache
2025/03/17 08:55:48 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:55:48 DEBUG : dir: Looking for writers
2025/03/17 08:55:48 DEBUG : fil/a/b: Looking for writers
2025/03/17 08:55:48 DEBUG : fil/a: Looking for writers
2025/03/17 08:55:48 DEBUG : b: reading active writers
2025/03/17 08:55:48 DEBUG : fil: Looking for writers
2025/03/17 08:55:48 DEBUG : a: reading active writers
2025/03/17 08:55:48 DEBUG : : Looking for writers
2025/03/17 08:55:48 DEBUG : dir: reading active writers
2025/03/17 08:55:48 DEBUG : fil: reading active writers
2025/03/17 08:55:48 DEBUG : >WaitForWriters: 
--- PASS: TestDirWalk (12.21s)
=== RUN   TestDirSetModTime
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:55:52 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:55:52 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:55:56 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:55:56 DEBUG : dir: Looking for writers
2025/03/17 08:55:56 DEBUG : : Looking for writers
2025/03/17 08:55:56 DEBUG : dir: reading active writers
2025/03/17 08:55:56 DEBUG : >WaitForWriters: 
--- PASS: TestDirSetModTime (5.52s)
=== RUN   TestDirStat
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:55:58 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:55:58 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:56:01 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:56:01 DEBUG : dir: Looking for writers
2025/03/17 08:56:01 DEBUG : file1: reading active writers
2025/03/17 08:56:01 DEBUG : : Looking for writers
2025/03/17 08:56:01 DEBUG : dir: reading active writers
2025/03/17 08:56:01 DEBUG : >WaitForWriters: 
--- PASS: TestDirStat (5.57s)
=== RUN   TestDirReadDirAll
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:56:03 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:56:03 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
=== RUN   TestDirReadDirAll/Virtual
2025/03/17 08:56:11 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile"
2025/03/17 08:56:11 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir"
2025/03/17 08:56:11 DEBUG : dir: Added virtual directory entry vDel: "file2"
2025/03/17 08:56:11 DEBUG : dir: Added virtual directory entry vDel: "subdir"
2025/03/17 08:56:17 DEBUG : dir: invalidating directory cache
2025/03/17 08:56:18 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir"
2025/03/17 08:56:18 DEBUG : dir: Removed virtual directory entry vDel: "file2"
2025/03/17 08:56:18 DEBUG : dir: Removed virtual directory entry vDel: "subdir"
2025/03/17 08:56:18 DEBUG : dir/file1: Reset virtual modtime
2025/03/17 08:56:18 DEBUG : dir: Removed virtual directory entry vAddFile: "virtualFile"
2025/03/17 08:56:18 DEBUG : dir/virtualFile: Reset virtual modtime
2025/03/17 08:56:18 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile2"
2025/03/17 08:56:18 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir2"
2025/03/17 08:56:18 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/03/17 08:56:18 DEBUG : dir: invalidating directory cache
2025/03/17 08:56:18 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir2"
2025/03/17 08:56:18 DEBUG : dir: Removed virtual directory entry vDel: "file1"
2025/03/17 08:56:18 DEBUG : dir/virtualFile: Reset virtual modtime
2025/03/17 08:56:18 DEBUG : : forgetting directory cache
2025/03/17 08:56:18 DEBUG : dir: forgetting directory cache
2025/03/17 08:56:18 DEBUG : dir/virtualDir: forgetting directory cache
2025/03/17 08:56:18 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:56:18 DEBUG : dir/virtualDir: Looking for writers
2025/03/17 08:56:18 DEBUG : dir: Looking for writers
2025/03/17 08:56:18 DEBUG : file1: reading active writers
2025/03/17 08:56:18 DEBUG : virtualFile2: reading active writers
2025/03/17 08:56:18 DEBUG : virtualFile: reading active writers
2025/03/17 08:56:18 DEBUG : virtualDir: reading active writers
2025/03/17 08:56:18 DEBUG : : Looking for writers
2025/03/17 08:56:18 DEBUG : dir: reading active writers
2025/03/17 08:56:18 DEBUG : >WaitForWriters: 
--- PASS: TestDirReadDirAll (18.47s)
    --- PASS: TestDirReadDirAll/Virtual (6.78s)
=== RUN   TestDirOpen
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:56:22 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:56:22 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:56:25 ERROR : dir/: Can only open directories read only
2025/03/17 08:56:25 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:56:25 DEBUG : dir: Looking for writers
2025/03/17 08:56:25 DEBUG : : Looking for writers
2025/03/17 08:56:25 DEBUG : dir: reading active writers
2025/03/17 08:56:25 DEBUG : >WaitForWriters: 
--- PASS: TestDirOpen (4.82s)
=== RUN   TestDirCreate
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:56:27 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:56:27 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:56:31 DEBUG : dir/potato: Open: flags=O_WRONLY|O_CREATE
2025/03/17 08:56:31 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2025/03/17 08:56:31 DEBUG : dir/potato: >Open: fd=dir/potato (w), err=<nil>
2025/03/17 08:56:31 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2025/03/17 08:56:31 DEBUG : proton drive root link ID 'rclone-test-rujaqif5yupo': File to upload is small (5 bytes), uploading instead of streaming
2025/03/17 08:56:32 DEBUG : dir/potato: sha1 = aaf4c61ddcc5e8a2dabede0f3b482cd9aea9434d OK
2025/03/17 08:56:32 DEBUG : dir/potato: Size and sha1 of src and dst objects identical
2025/03/17 08:56:32 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2025/03/17 08:56:32 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:56:32 DEBUG : dir: Looking for writers
2025/03/17 08:56:32 DEBUG : file1: reading active writers
2025/03/17 08:56:32 DEBUG : potato: reading active writers
2025/03/17 08:56:32 DEBUG : : Looking for writers
2025/03/17 08:56:32 DEBUG : dir: reading active writers
2025/03/17 08:56:32 DEBUG : >WaitForWriters: 
--- PASS: TestDirCreate (8.19s)
=== RUN   TestDirMkdir
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:56:35 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:56:35 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:56:39 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2025/03/17 08:56:41 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:56:41 DEBUG : dir/sub: Looking for writers
2025/03/17 08:56:41 DEBUG : dir: Looking for writers
2025/03/17 08:56:41 DEBUG : file1: reading active writers
2025/03/17 08:56:41 DEBUG : sub: reading active writers
2025/03/17 08:56:41 DEBUG : : Looking for writers
2025/03/17 08:56:41 DEBUG : dir: reading active writers
2025/03/17 08:56:41 DEBUG : >WaitForWriters: 
--- PASS: TestDirMkdir (8.24s)
=== RUN   TestDirMkdirSub
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:56:43 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:56:43 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:56:47 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2025/03/17 08:56:48 DEBUG : dir/sub: Added virtual directory entry vAddDir: "subsub"
2025/03/17 08:56:50 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:56:50 DEBUG : dir/sub/subsub: Looking for writers
2025/03/17 08:56:50 DEBUG : dir/sub: Looking for writers
2025/03/17 08:56:50 DEBUG : subsub: reading active writers
2025/03/17 08:56:50 DEBUG : dir: Looking for writers
2025/03/17 08:56:50 DEBUG : file1: reading active writers
2025/03/17 08:56:50 DEBUG : sub: reading active writers
2025/03/17 08:56:50 DEBUG : : Looking for writers
2025/03/17 08:56:50 DEBUG : dir: reading active writers
2025/03/17 08:56:50 DEBUG : >WaitForWriters: 
--- PASS: TestDirMkdirSub (9.93s)
=== RUN   TestDirRemove
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:56:53 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:56:53 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:56:57 ERROR : dir/: Dir.Remove not empty
2025/03/17 08:56:57 DEBUG : dir/file1: Remove: 
2025/03/17 08:56:57 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/03/17 08:56:57 DEBUG : dir/file1: >Remove: err=<nil>
2025/03/17 08:56:57 DEBUG : : Added virtual directory entry vDel: "dir"
2025/03/17 08:56:58 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:56:58 DEBUG : : Looking for writers
2025/03/17 08:56:58 DEBUG : >WaitForWriters: 
--- PASS: TestDirRemove (5.29s)
=== RUN   TestDirRemoveAll
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:56:58 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:56:58 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:57:02 DEBUG : dir/file1: Remove: 
2025/03/17 08:57:02 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/03/17 08:57:02 DEBUG : dir/file1: >Remove: err=<nil>
2025/03/17 08:57:03 DEBUG : : Added virtual directory entry vDel: "dir"
2025/03/17 08:57:03 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:57:03 DEBUG : : Looking for writers
2025/03/17 08:57:03 DEBUG : >WaitForWriters: 
--- PASS: TestDirRemoveAll (5.63s)
=== RUN   TestDirRemoveName
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:57:04 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:57:04 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:57:07 DEBUG : dir/file1: Remove: 
2025/03/17 08:57:08 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/03/17 08:57:08 DEBUG : dir/file1: >Remove: err=<nil>
2025/03/17 08:57:09 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:57:09 DEBUG : dir: Looking for writers
2025/03/17 08:57:09 DEBUG : : Looking for writers
2025/03/17 08:57:09 DEBUG : dir: reading active writers
2025/03/17 08:57:09 DEBUG : >WaitForWriters: 
--- PASS: TestDirRemoveName (6.34s)
=== RUN   TestDirRename
    run.go:180: Remote "proton drive root link ID 'rclone-test-rujaqif5yupo'", Local "Local file system at /tmp/rclone1438929192", Modify Window "1s"
2025/03/17 08:57:10 INFO  : proton drive root link ID 'rclone-test-rujaqif5yupo': poll-interval is not supported by this remote
2025/03/17 08:57:10 NOTICE: proton drive root link ID 'rclone-test-rujaqif5yupo': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/17 08:57:16 ERROR : dir/not found: Dir.Rename error: file does not exist
2025/03/17 08:57:16.944514 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rFTaUDe2pkFbu10bjLTTPUCXN1JEUZvJzZ0FOJrnFH6ujms8udPGlC8IvHZErekeOj6Jc_MTrXVlhmG2IRwT2w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1
2025/03/17 08:57:16.944542 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rFTaUDe2pkFbu10bjLTTPUCXN1JEUZvJzZ0FOJrnFH6ujms8udPGlC8IvHZErekeOj6Jc_MTrXVlhmG2IRwT2w==/move: This value should not be blank. (Code=2000, Status=400)
2025/03/17 08:57:16 ERROR : dir: Dir.Rename error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rFTaUDe2pkFbu10bjLTTPUCXN1JEUZvJzZ0FOJrnFH6ujms8udPGlC8IvHZErekeOj6Jc_MTrXVlhmG2IRwT2w==/move: This value should not be blank. (Code=2000, Status=400)
    dir_test.go:537: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:537
        	Error:      	Received unexpected error:
        	            	400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rFTaUDe2pkFbu10bjLTTPUCXN1JEUZvJzZ0FOJrnFH6ujms8udPGlC8IvHZErekeOj6Jc_MTrXVlhmG2IRwT2w==/move: This value should not be blank. (Code=2000, Status=400)
        	Test:       	TestDirRename
    dir_test.go:249: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:249
        	            				/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:538
        	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:544
        	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:544
        	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:544
        	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:544
        	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:544
        	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:548: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:548
        	Error:      	Received unexpected error:
        	            	file does not exist
        	Test:       	TestDirRename
2025/03/17 08:59:15 DEBUG : WaitForWriters: timeout=30s
2025/03/17 08:59:15 DEBUG : dir: Looking for writers
2025/03/17 08:59:15 DEBUG : file1: reading active writers
2025/03/17 08:59:15 DEBUG : file3: reading active writers
2025/03/17 08:59:15 DEBUG : : Looking for writers
2025/03/17 08:59:15 DEBUG : dir: reading active writers
2025/03/17 08:59:15 DEBUG : >WaitForWriters: 
--- FAIL: TestDirRename (181.92s)
panic: interface conversion: vfs.Node is nil, not *vfs.Dir [recovered]
	panic: interface conversion: vfs.Node is nil, not *vfs.Dir

goroutine 1658 [running]:
testing.tRunner.func1.2({0x2240c20, 0xc000b87ce0})
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1632 +0x230
testing.tRunner.func1()
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1635 +0x35e
panic({0x2240c20?, 0xc000b87ce0?})
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:785 +0x132
github.com/rclone/rclone/vfs.TestDirRename(0xc000722340)
	/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:549 +0x10d1
testing.tRunner(0xc000722340, 0x27efcd8)
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4
created by testing.(*T).Run in goroutine 1
	/home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390
"./vfs.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose" - Finished ERROR in 5m10.633571309s (try 1/5): exit status 2: Failed [TestDirRename]