"./vfs.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose" - Starting (try 1/5)
2025/03/27 02:07:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-lidineh6tuvi"
2025/03/27 02:07:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/27 02:07:23 DEBUG : proton drive root link ID 'rclone-test-lidineh6tuvi': Has cached credentials
2025/03/27 02:07:24 DEBUG : proton drive root link ID 'rclone-test-lidineh6tuvi': Used cached credential to initialize the ProtonDrive API
2025/03/27 02:07:24 DEBUG : Creating backend with remote "/tmp/rclone1696806"
=== RUN TestDirHandleMethods
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:07:24 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:07:24 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:07:27 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:07:27 DEBUG : dir: Looking for writers
2025/03/27 02:07:27 DEBUG : : Looking for writers
2025/03/27 02:07:27 DEBUG : dir: reading active writers
2025/03/27 02:07:27 DEBUG : >WaitForWriters:
--- PASS: TestDirHandleMethods (3.46s)
=== RUN TestDirHandleReaddir
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:07:28 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:07:28 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:07:33 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:07:33 DEBUG : dir/subdir: Looking for writers
2025/03/27 02:07:33 DEBUG : dir: Looking for writers
2025/03/27 02:07:33 DEBUG : file1: reading active writers
2025/03/27 02:07:33 DEBUG : file2: reading active writers
2025/03/27 02:07:33 DEBUG : subdir: reading active writers
2025/03/27 02:07:33 DEBUG : : Looking for writers
2025/03/27 02:07:33 DEBUG : dir: reading active writers
2025/03/27 02:07:33 DEBUG : >WaitForWriters:
--- PASS: TestDirHandleReaddir (6.71s)
=== RUN TestDirHandleReaddirnames
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:07:34 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:07:34 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:07:36 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:07:36 DEBUG : dir: Looking for writers
2025/03/27 02:07:36 DEBUG : file1: reading active writers
2025/03/27 02:07:36 DEBUG : : Looking for writers
2025/03/27 02:07:36 DEBUG : dir: reading active writers
2025/03/27 02:07:36 DEBUG : >WaitForWriters:
--- PASS: TestDirHandleReaddirnames (3.01s)
=== RUN TestDirMethods
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:07:37 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:07:37 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:07:39 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:07:39 DEBUG : dir: Looking for writers
2025/03/27 02:07:39 DEBUG : : Looking for writers
2025/03/27 02:07:39 DEBUG : dir: reading active writers
2025/03/27 02:07:39 DEBUG : >WaitForWriters:
--- PASS: TestDirMethods (2.68s)
=== RUN TestDirForgetAll
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:07:40 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:07:40 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:07:42 DEBUG : dir: forgetting directory cache
2025/03/27 02:07:42 DEBUG : : forgetting directory cache
2025/03/27 02:07:42 DEBUG : dir: forgetting directory cache
2025/03/27 02:07:42 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:07:42 DEBUG : : Looking for writers
2025/03/27 02:07:42 DEBUG : >WaitForWriters:
--- PASS: TestDirForgetAll (3.20s)
=== RUN TestDirForgetPath
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:07:43 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:07:43 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:07:46 DEBUG : : ForgetPath: relativePath="dir/notfound", type=1
2025/03/27 02:07:46 DEBUG : dir: invalidating directory cache
2025/03/27 02:07:46 DEBUG : : >ForgetPath:
2025/03/27 02:07:46 DEBUG : : ForgetPath: relativePath="dir", type=0
2025/03/27 02:07:46 DEBUG : : invalidating directory cache
2025/03/27 02:07:46 DEBUG : dir: forgetting directory cache
2025/03/27 02:07:46 DEBUG : : >ForgetPath:
2025/03/27 02:07:46 DEBUG : : ForgetPath: relativePath="not/in/cache", type=0
2025/03/27 02:07:46 DEBUG : : >ForgetPath:
2025/03/27 02:07:46 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:07:46 DEBUG : dir: Looking for writers
2025/03/27 02:07:46 DEBUG : : Looking for writers
2025/03/27 02:07:46 DEBUG : dir: reading active writers
2025/03/27 02:07:46 DEBUG : >WaitForWriters:
--- PASS: TestDirForgetPath (3.23s)
=== RUN TestDirWalk
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:07:47 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:07:47 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:07:51 DEBUG : : forgetting directory cache
2025/03/27 02:07:51 DEBUG : dir: forgetting directory cache
2025/03/27 02:07:51 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:07:51 DEBUG : dir: Looking for writers
2025/03/27 02:07:51 DEBUG : fil/a/b: Looking for writers
2025/03/27 02:07:51 DEBUG : fil/a: Looking for writers
2025/03/27 02:07:51 DEBUG : b: reading active writers
2025/03/27 02:07:51 DEBUG : fil: Looking for writers
2025/03/27 02:07:51 DEBUG : a: reading active writers
2025/03/27 02:07:51 DEBUG : : Looking for writers
2025/03/27 02:07:51 DEBUG : dir: reading active writers
2025/03/27 02:07:51 DEBUG : fil: reading active writers
2025/03/27 02:07:51 DEBUG : >WaitForWriters:
--- PASS: TestDirWalk (7.05s)
=== RUN TestDirSetModTime
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:07:54 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:07:54 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:07:56 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:07:56 DEBUG : dir: Looking for writers
2025/03/27 02:07:56 DEBUG : : Looking for writers
2025/03/27 02:07:56 DEBUG : dir: reading active writers
2025/03/27 02:07:56 DEBUG : >WaitForWriters:
--- PASS: TestDirSetModTime (3.08s)
=== RUN TestDirStat
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:07:57 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:07:57 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:07:59 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:07:59 DEBUG : dir: Looking for writers
2025/03/27 02:07:59 DEBUG : file1: reading active writers
2025/03/27 02:07:59 DEBUG : : Looking for writers
2025/03/27 02:07:59 DEBUG : dir: reading active writers
2025/03/27 02:07:59 DEBUG : >WaitForWriters:
--- PASS: TestDirStat (3.25s)
=== RUN TestDirReadDirAll
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:08:00 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:08:00 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
=== RUN TestDirReadDirAll/Virtual
2025/03/27 02:08:04 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile"
2025/03/27 02:08:04 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir"
2025/03/27 02:08:04 DEBUG : dir: Added virtual directory entry vDel: "file2"
2025/03/27 02:08:04 DEBUG : dir: Added virtual directory entry vDel: "subdir"
2025/03/27 02:08:07 DEBUG : dir: invalidating directory cache
2025/03/27 02:08:08 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir"
2025/03/27 02:08:08 DEBUG : dir: Removed virtual directory entry vDel: "file2"
2025/03/27 02:08:08 DEBUG : dir: Removed virtual directory entry vDel: "subdir"
2025/03/27 02:08:08 DEBUG : dir/file1: Reset virtual modtime
2025/03/27 02:08:08 DEBUG : dir: Removed virtual directory entry vAddFile: "virtualFile"
2025/03/27 02:08:08 DEBUG : dir/virtualFile: Reset virtual modtime
2025/03/27 02:08:08 DEBUG : dir: Added virtual directory entry vAddFile: "virtualFile2"
2025/03/27 02:08:08 DEBUG : dir: Added virtual directory entry vAddDir: "virtualDir2"
2025/03/27 02:08:08 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/03/27 02:08:08 DEBUG : dir: invalidating directory cache
2025/03/27 02:08:08 DEBUG : dir: Removed virtual directory entry vAddDir: "virtualDir2"
2025/03/27 02:08:08 DEBUG : dir: Removed virtual directory entry vDel: "file1"
2025/03/27 02:08:08 DEBUG : dir/virtualFile: Reset virtual modtime
2025/03/27 02:08:08 DEBUG : : forgetting directory cache
2025/03/27 02:08:08 DEBUG : dir: forgetting directory cache
2025/03/27 02:08:08 DEBUG : dir/virtualDir: forgetting directory cache
2025/03/27 02:08:08 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:08:08 DEBUG : dir/virtualDir: Looking for writers
2025/03/27 02:08:08 DEBUG : dir: Looking for writers
2025/03/27 02:08:08 DEBUG : virtualFile2: reading active writers
2025/03/27 02:08:08 DEBUG : virtualFile: reading active writers
2025/03/27 02:08:08 DEBUG : virtualDir: reading active writers
2025/03/27 02:08:08 DEBUG : file1: reading active writers
2025/03/27 02:08:08 DEBUG : : Looking for writers
2025/03/27 02:08:08 DEBUG : dir: reading active writers
2025/03/27 02:08:08 DEBUG : >WaitForWriters:
--- PASS: TestDirReadDirAll (9.91s)
--- PASS: TestDirReadDirAll/Virtual (3.55s)
=== RUN TestDirOpen
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:08:10 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:08:10 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:08:12 ERROR : dir/: Can only open directories read only
2025/03/27 02:08:12 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:08:12 DEBUG : dir: Looking for writers
2025/03/27 02:08:12 DEBUG : : Looking for writers
2025/03/27 02:08:12 DEBUG : dir: reading active writers
2025/03/27 02:08:12 DEBUG : >WaitForWriters:
--- PASS: TestDirOpen (3.00s)
=== RUN TestDirCreate
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:08:13 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:08:13 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:08:15 DEBUG : dir/potato: Open: flags=O_WRONLY|O_CREATE
2025/03/27 02:08:15 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2025/03/27 02:08:15 DEBUG : dir/potato: >Open: fd=dir/potato (w), err=<nil>
2025/03/27 02:08:15 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2025/03/27 02:08:15 DEBUG : proton drive root link ID 'rclone-test-lidineh6tuvi': File to upload is small (5 bytes), uploading instead of streaming
2025/03/27 02:08:15 DEBUG : dir/potato: sha1 = aaf4c61ddcc5e8a2dabede0f3b482cd9aea9434d OK
2025/03/27 02:08:15 DEBUG : dir/potato: Size and sha1 of src and dst objects identical
2025/03/27 02:08:15 DEBUG : dir: Added virtual directory entry vAddFile: "potato"
2025/03/27 02:08:15 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:08:15 DEBUG : dir: Looking for writers
2025/03/27 02:08:15 DEBUG : file1: reading active writers
2025/03/27 02:08:15 DEBUG : potato: reading active writers
2025/03/27 02:08:15 DEBUG : : Looking for writers
2025/03/27 02:08:15 DEBUG : dir: reading active writers
2025/03/27 02:08:15 DEBUG : >WaitForWriters:
--- PASS: TestDirCreate (3.93s)
=== RUN TestDirMkdir
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:08:17 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:08:17 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:08:19 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2025/03/27 02:08:20 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:08:20 DEBUG : dir/sub: Looking for writers
2025/03/27 02:08:20 DEBUG : dir: Looking for writers
2025/03/27 02:08:20 DEBUG : file1: reading active writers
2025/03/27 02:08:20 DEBUG : sub: reading active writers
2025/03/27 02:08:20 DEBUG : : Looking for writers
2025/03/27 02:08:20 DEBUG : dir: reading active writers
2025/03/27 02:08:20 DEBUG : >WaitForWriters:
--- PASS: TestDirMkdir (4.71s)
=== RUN TestDirMkdirSub
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:08:22 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:08:22 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:08:24 DEBUG : dir: Added virtual directory entry vAddDir: "sub"
2025/03/27 02:08:25 DEBUG : dir/sub: Added virtual directory entry vAddDir: "subsub"
2025/03/27 02:08:25 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:08:25 DEBUG : dir/sub/subsub: Looking for writers
2025/03/27 02:08:25 DEBUG : dir/sub: Looking for writers
2025/03/27 02:08:25 DEBUG : subsub: reading active writers
2025/03/27 02:08:25 DEBUG : dir: Looking for writers
2025/03/27 02:08:25 DEBUG : sub: reading active writers
2025/03/27 02:08:25 DEBUG : file1: reading active writers
2025/03/27 02:08:25 DEBUG : : Looking for writers
2025/03/27 02:08:25 DEBUG : dir: reading active writers
2025/03/27 02:08:25 DEBUG : >WaitForWriters:
--- PASS: TestDirMkdirSub (5.73s)
=== RUN TestDirRemove
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:08:27 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:08:27 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:08:29 ERROR : dir/: Dir.Remove not empty
2025/03/27 02:08:29 DEBUG : dir/file1: Remove:
2025/03/27 02:08:29 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/03/27 02:08:29 DEBUG : dir/file1: >Remove: err=<nil>
2025/03/27 02:08:30 DEBUG : : Added virtual directory entry vDel: "dir"
2025/03/27 02:08:30 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:08:30 DEBUG : : Looking for writers
2025/03/27 02:08:30 DEBUG : >WaitForWriters:
--- PASS: TestDirRemove (3.03s)
=== RUN TestDirRemoveAll
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:08:30 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:08:30 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:08:32 DEBUG : dir/file1: Remove:
2025/03/27 02:08:33 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/03/27 02:08:33 DEBUG : dir/file1: >Remove: err=<nil>
2025/03/27 02:08:33 DEBUG : : Added virtual directory entry vDel: "dir"
2025/03/27 02:08:33 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:08:33 DEBUG : : Looking for writers
2025/03/27 02:08:33 DEBUG : >WaitForWriters:
--- PASS: TestDirRemoveAll (3.17s)
=== RUN TestDirRemoveName
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:08:33 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:08:33 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:08:35 DEBUG : dir/file1: Remove:
2025/03/27 02:08:36 DEBUG : dir: Added virtual directory entry vDel: "file1"
2025/03/27 02:08:36 DEBUG : dir/file1: >Remove: err=<nil>
2025/03/27 02:08:36 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:08:36 DEBUG : dir: Looking for writers
2025/03/27 02:08:36 DEBUG : : Looking for writers
2025/03/27 02:08:36 DEBUG : dir: reading active writers
2025/03/27 02:08:36 DEBUG : >WaitForWriters:
--- PASS: TestDirRemoveName (3.38s)
=== RUN TestDirRename
run.go:180: Remote "proton drive root link ID 'rclone-test-lidineh6tuvi'", Local "Local file system at /tmp/rclone1696806", Modify Window "1s"
2025/03/27 02:08:37 INFO : proton drive root link ID 'rclone-test-lidineh6tuvi': poll-interval is not supported by this remote
2025/03/27 02:08:37 NOTICE: proton drive root link ID 'rclone-test-lidineh6tuvi': --vfs-cache-mode writes or full is recommended for this remote as it can't stream
2025/03/27 02:08:40 ERROR : dir/not found: Dir.Rename error: file does not exist
2025/03/27 02:08:41.066058 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ktTJONWzmPOTT066ngMJaKVgvmgPicQl-W_eyrcKUeSJVgD6ZubDgk2QphLEarOIU20vPwpZNE2ZIa3f6qKfug==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1
2025/03/27 02:08:41.066097 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ktTJONWzmPOTT066ngMJaKVgvmgPicQl-W_eyrcKUeSJVgD6ZubDgk2QphLEarOIU20vPwpZNE2ZIa3f6qKfug==/move: This value should not be blank. (Code=2000, Status=400)
2025/03/27 02:08:41 ERROR : dir: Dir.Rename error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ktTJONWzmPOTT066ngMJaKVgvmgPicQl-W_eyrcKUeSJVgD6ZubDgk2QphLEarOIU20vPwpZNE2ZIa3f6qKfug==/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/ktTJONWzmPOTT066ngMJaKVgvmgPicQl-W_eyrcKUeSJVgD6ZubDgk2QphLEarOIU20vPwpZNE2ZIa3f6qKfug==/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/27 02:10:21 DEBUG : WaitForWriters: timeout=30s
2025/03/27 02:10:21 DEBUG : dir: Looking for writers
2025/03/27 02:10:21 DEBUG : file3: reading active writers
2025/03/27 02:10:21 DEBUG : file1: reading active writers
2025/03/27 02:10:21 DEBUG : : Looking for writers
2025/03/27 02:10:21 DEBUG : dir: reading active writers
2025/03/27 02:10:21 DEBUG : >WaitForWriters:
--- FAIL: TestDirRename (152.37s)
panic: interface conversion: vfs.Node is nil, not *vfs.Dir [recovered]
panic: interface conversion: vfs.Node is nil, not *vfs.Dir
goroutine 1674 [running]:
testing.tRunner.func1.2({0x2241cc0, 0xc0005cb740})
/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({0x2241cc0?, 0xc0005cb740?})
/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(0xc000168820)
/home/rclone/go/src/github.com/rclone/rclone/vfs/dir_test.go:549 +0x10d1
testing.tRunner(0xc000168820, 0x27f1378)
/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 3m46.102079806s (try 1/5): exit status 2: Failed [TestDirRename]