[unraid] rclone Permission and writefilehandle.write Issue

Command: rclone mount --allow-other --buffer-size 256M --dir-cache-time 96h --timeout 1h --default-permissions --uid 99 --gid 100 --umask 002 -vv gdrive: /mnt/disks/ua_hdd1/gdrive &

  1. I am able to access the Google Drive Content.
  2. I am able to make the Samba on my Windows Computer.
  3. I am able to browser the Google Drive Content on Windows Computer.

Issue: If I am copying anything from Windows to Samba Share, it is giving me permission error.

It makes the 0-1 KB File and says "You need permission to perform this action".

Screenshot: https://i.imgur.com/sAnLaeu.png

Please help!

Log:

2020/12/27 00:58:06 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=0
2020/12/27 00:58:06 DEBUG : 100MB.bin: waiting for in-sequence write to 0 for 1s
2020/12/27 00:58:07 DEBUG : 100MB.bin: aborting in-sequence write wait, off=0
2020/12/27 00:58:07 DEBUG : 100MB.bin: failed to wait for in-sequence write to 0
2020/12/27 00:58:07 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:07 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:07 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:07 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:07 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=1048576
2020/12/27 00:58:07 DEBUG : 100MB.bin: waiting for in-sequence write to 1048576 for 1s
2020/12/27 00:58:07 DEBUG : /: Attr:
2020/12/27 00:58:07 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:07 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:07 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:07 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:07 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:08 DEBUG : 100MB.bin: aborting in-sequence write wait, off=1048576
2020/12/27 00:58:08 DEBUG : 100MB.bin: failed to wait for in-sequence write to 1048576
2020/12/27 00:58:08 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:08 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:08 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=2097152
2020/12/27 00:58:08 DEBUG : 100MB.bin: waiting for in-sequence write to 2097152 for 1s
2020/12/27 00:58:09 DEBUG : 100MB.bin: aborting in-sequence write wait, off=2097152
2020/12/27 00:58:09 DEBUG : 100MB.bin: failed to wait for in-sequence write to 2097152
2020/12/27 00:58:09 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes```

--vfs-cache-mode >= writes
that implies the mode is not set correctly.
that log file is missing the top part, with the command and other start-up stuff, can you post it?

When I copy anything from Samba Share to Windows: It is copying fine. Everything is working as expected.

When I copy anything from Windows to Samba Share: It is throwing the above mentioned error.

you command is missing --vfs-cache-mode, thus that error

This Post has full log file in the end: [unraid] rclone Permission and writefilehandle.write Issue

But, I have mentioned it here again:

2020/12/27 00:56:51 DEBUG : rclone: Version "v1.53.3" starting with parameters ["rcloneorig" "--config" "/boot/config/plugins/rclone/.rclone.conf" "mount" "--allow-other" "--buffer-size" "256M" "--dir-cache-time" "96h" "--timeout" "1h" "--default-permissions" "--uid" "99" "--gid" "100" "--umask" "002" "-vv" "gdrive:" "/mnt/disks/ua_hdd1/gdrive"]
2020/12/27 00:56:51 DEBUG : Creating backend with remote "gdrive:"
2020/12/27 00:56:51 DEBUG : Using config file from "/boot/config/plugins/rclone/.rclone.conf"
2020/12/27 00:56:51 DEBUG : Google drive root '': Mounting on "/mnt/disks/ua_hdd1/gdrive"
2020/12/27 00:56:51 DEBUG : : Root:
2020/12/27 00:56:51 DEBUG : : >Root: node=/, err=
2020/12/27 00:56:57 DEBUG : /: Attr:
2020/12/27 00:56:57 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:56:57 DEBUG : : Statfs:
2020/12/27 00:56:58 DEBUG : Google drive root '': read info from team drive "AlexJohn1"
2020/12/27 00:56:58 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2020/12/27 00:56:58 DEBUG : /: Attr:
2020/12/27 00:56:58 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:56:58 DEBUG : : Statfs:
2020/12/27 00:56:58 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2020/12/27 00:57:51 DEBUG : /: Attr:
2020/12/27 00:57:51 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:57:51 DEBUG : /: Lookup: name="Desktop.ini"
2020/12/27 00:57:51 DEBUG : Google drive root '': Checking for changes on remote
2020/12/27 00:57:51 DEBUG : /: >Lookup: node=, err=no such file or directory
2020/12/27 00:57:51 DEBUG : /: Lookup: name="Desktop.ini"
2020/12/27 00:57:51 DEBUG : /: >Lookup: node=, err=no such file or directory
2020/12/27 00:57:51 DEBUG : /: ReadDirAll:
2020/12/27 00:57:51 DEBUG : /: >ReadDirAll: item=11, err=
2020/12/27 00:57:51 DEBUG : /: Attr:
2020/12/27 00:57:51 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:57:51 DEBUG : /: Lookup: name="AutoRun.inf"
2020/12/27 00:57:51 DEBUG : /: >Lookup: node=, err=no such file or directory
2020/12/27 00:57:51 DEBUG : /: Lookup: name="AutoRun.inf"
2020/12/27 00:57:51 DEBUG : /: >Lookup: node=, err=no such file or directory
2020/12/27 00:57:51 DEBUG : /: ReadDirAll:
2020/12/27 00:57:51 DEBUG : /: >ReadDirAll: item=11, err=
2020/12/27 00:57:53 DEBUG : /: Attr:
2020/12/27 00:57:53 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:57:53 DEBUG : : Statfs:
2020/12/27 00:57:53 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2020/12/27 00:57:53 DEBUG : : Statfs:
2020/12/27 00:57:53 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2020/12/27 00:58:01 DEBUG : /: Attr:
2020/12/27 00:58:01 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="desktop.ini"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=, err=no such file or directory
2020/12/27 00:58:01 DEBUG : /: Lookup: name="desktop.ini"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=, err=no such file or directory
2020/12/27 00:58:01 DEBUG : /: ReadDirAll:
2020/12/27 00:58:01 DEBUG : /: >ReadDirAll: item=11, err=
2020/12/27 00:58:01 DEBUG : /: Attr:
2020/12/27 00:58:01 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: ReadDirAll:
2020/12/27 00:58:01 DEBUG : /: >ReadDirAll: item=11, err=
2020/12/27 00:58:01 DEBUG : /: Attr:
2020/12/27 00:58:01 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="5GB1.bin"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=5GB1.bin, err=
2020/12/27 00:58:01 DEBUG : 5GB1.bin: Attr:
2020/12/27 00:58:01 DEBUG : 5GB1.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="P"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=P/, err=
2020/12/27 00:58:01 DEBUG : P/: Attr:
2020/12/27 00:58:01 DEBUG : P/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="Test1"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=Test1/, err=
2020/12/27 00:58:01 DEBUG : Test1/: Attr:
2020/12/27 00:58:01 DEBUG : Test1/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="bu"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=bu/, err=
2020/12/27 00:58:01 DEBUG : bu/: Attr:
2020/12/27 00:58:01 DEBUG : bu/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="media"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=media/, err=
2020/12/27 00:58:01 DEBUG : media/: Attr:
2020/12/27 00:58:01 DEBUG : media/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="media_swizzin"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=media_swizzin/, err=
2020/12/27 00:58:01 DEBUG : media_swizzin/: Attr:
2020/12/27 00:58:01 DEBUG : media_swizzin/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="nzb"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=nzb/, err=
2020/12/27 00:58:01 DEBUG : nzb/: Attr:
2020/12/27 00:58:01 DEBUG : nzb/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="test"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=test/, err=
2020/12/27 00:58:01 DEBUG : test/: Attr:
2020/12/27 00:58:01 DEBUG : test/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="torrent"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=torrent/, err=
2020/12/27 00:58:01 DEBUG : torrent/: Attr:
2020/12/27 00:58:01 DEBUG : torrent/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="youtube"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=youtube/, err=
2020/12/27 00:58:01 DEBUG : youtube/: Attr:
2020/12/27 00:58:01 DEBUG : youtube/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Lookup: name="yt"
2020/12/27 00:58:01 DEBUG : /: >Lookup: node=yt/, err=
2020/12/27 00:58:01 DEBUG : yt/: Attr:
2020/12/27 00:58:01 DEBUG : yt/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:01 DEBUG : /: Attr:
2020/12/27 00:58:01 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:02 DEBUG : yt/: ReadDirAll:
2020/12/27 00:58:02 DEBUG : yt/: >ReadDirAll: item=1, err=
2020/12/27 00:58:02 DEBUG : yt/: Attr:
2020/12/27 00:58:02 DEBUG : yt/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:02 DEBUG : yt/: Lookup: name="1"
2020/12/27 00:58:02 DEBUG : yt/: >Lookup: node=yt/1/, err=
2020/12/27 00:58:02 DEBUG : yt/1/: Attr:
2020/12/27 00:58:02 DEBUG : yt/1/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:02 DEBUG : /: Attr:
2020/12/27 00:58:02 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:02 DEBUG : /: Lookup: name="yt"
2020/12/27 00:58:02 DEBUG : /: >Lookup: node=yt/, err=
2020/12/27 00:58:02 DEBUG : yt/: Attr:
2020/12/27 00:58:02 DEBUG : yt/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:02 DEBUG : yt/: Attr:
2020/12/27 00:58:02 DEBUG : yt/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:02 DEBUG : yt/1/: ReadDirAll:
2020/12/27 00:58:03 DEBUG : yt/1/: >ReadDirAll: item=0, err=
2020/12/27 00:58:03 DEBUG : yt/1/: Attr:
2020/12/27 00:58:03 DEBUG : yt/1/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Attr:
2020/12/27 00:58:05 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : : Statfs:
2020/12/27 00:58:05 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2020/12/27 00:58:05 DEBUG : /: ReadDirAll:
2020/12/27 00:58:05 DEBUG : /: >ReadDirAll: item=11, err=
2020/12/27 00:58:05 DEBUG : /: Attr:
2020/12/27 00:58:05 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="5GB1.bin"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=5GB1.bin, err=
2020/12/27 00:58:05 DEBUG : 5GB1.bin: Attr:
2020/12/27 00:58:05 DEBUG : 5GB1.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="P"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=P/, err=
2020/12/27 00:58:05 DEBUG : P/: Attr:
2020/12/27 00:58:05 DEBUG : P/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="Test1"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=Test1/, err=
2020/12/27 00:58:05 DEBUG : Test1/: Attr:
2020/12/27 00:58:05 DEBUG : Test1/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="bu"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=bu/, err=
2020/12/27 00:58:05 DEBUG : bu/: Attr:
2020/12/27 00:58:05 DEBUG : bu/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="media"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=media/, err=
2020/12/27 00:58:05 DEBUG : media/: Attr:
2020/12/27 00:58:05 DEBUG : media/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="media_swizzin"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=media_swizzin/, err=
2020/12/27 00:58:05 DEBUG : media_swizzin/: Attr:
2020/12/27 00:58:05 DEBUG : media_swizzin/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="nzb"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=nzb/, err=
2020/12/27 00:58:05 DEBUG : nzb/: Attr:
2020/12/27 00:58:05 DEBUG : nzb/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="test"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=test/, err=
2020/12/27 00:58:05 DEBUG : test/: Attr:
2020/12/27 00:58:05 DEBUG : test/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="torrent"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=torrent/, err=
2020/12/27 00:58:05 DEBUG : torrent/: Attr:
2020/12/27 00:58:05 DEBUG : torrent/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="youtube"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=youtube/, err=
2020/12/27 00:58:05 DEBUG : youtube/: Attr:
2020/12/27 00:58:05 DEBUG : youtube/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="yt"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=yt/, err=
2020/12/27 00:58:05 DEBUG : yt/: Attr:
2020/12/27 00:58:05 DEBUG : yt/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Attr:
2020/12/27 00:58:05 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="100MB.bin"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=, err=no such file or directory
2020/12/27 00:58:05 DEBUG : /: Lookup: name="100MB.bin"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=, err=no such file or directory
2020/12/27 00:58:05 DEBUG : /: ReadDirAll:
2020/12/27 00:58:05 DEBUG : /: >ReadDirAll: item=11, err=
2020/12/27 00:58:05 DEBUG : /: Attr:
2020/12/27 00:58:05 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : /: Lookup: name="100MB.bin"
2020/12/27 00:58:05 DEBUG : /: >Lookup: node=, err=no such file or directory
2020/12/27 00:58:05 DEBUG : /: Create: name="100MB.bin"
2020/12/27 00:58:05 DEBUG : 100MB.bin: Open: flags=O_RDWR|O_CREATE|O_EXCL
2020/12/27 00:58:05 DEBUG : : Added virtual directory entry vAdd: "100MB.bin"
2020/12/27 00:58:05 DEBUG : 100MB.bin: >Open: fd=100MB.bin (w), err=
2020/12/27 00:58:05 DEBUG : /: >Create: node=100MB.bin, handle=&{100MB.bin (w)}, err=
2020/12/27 00:58:05 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:05 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=0 mode=-rw-rw-r--, err=
2020/12/27 00:58:05 DEBUG : /: Attr:
2020/12/27 00:58:05 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:05 DEBUG : 100MB.bin: Setattr: a=Setattr [ID=0xbf Node=0xe Uid=99 Gid=100 Pid=610] mode=-rw-rw-rw- handle=INVALID-0x0
2020/12/27 00:58:05 DEBUG : 100MB.bin: >Setattr: err=
2020/12/27 00:58:05 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:05 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=0 mode=-rw-rw-r--, err=
2020/12/27 00:58:05 DEBUG : 100MB.bin: Setattr: a=Setattr [ID=0xc0 Node=0xe Uid=99 Gid=100 Pid=610] size=104857600 handle=0x2 lockowner
2020/12/27 00:58:05 DEBUG : 100MB.bin: Truncating 1 file handles
2020/12/27 00:58:05 ERROR : 100MB.bin: WriteFileHandle: Truncate: Can't change size without --vfs-cache-mode >= writes
2020/12/27 00:58:05 DEBUG : 100MB.bin: >Setattr: err=operation not permitted
2020/12/27 00:58:05 DEBUG : &{100MB.bin (w)}: Write: len=1, offset=104857599
2020/12/27 00:58:05 DEBUG : 100MB.bin: waiting for in-sequence write to 104857599 for 1s
2020/12/27 00:58:06 DEBUG : 100MB.bin: aborting in-sequence write wait, off=104857599
2020/12/27 00:58:06 DEBUG : 100MB.bin: failed to wait for in-sequence write to 104857599
2020/12/27 00:58:06 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:06 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:06 DEBUG : &{100MB.bin (w)}: Write: len=1, offset=0
2020/12/27 00:58:06 DEBUG : : Added virtual directory entry vAdd: "100MB.bin"
2020/12/27 00:58:06 DEBUG : &{100MB.bin (w)}: >Write: written=1, err=
2020/12/27 00:58:06 DEBUG : /: Attr:
2020/12/27 00:58:06 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:06 DEBUG : 100MB.bin: Setattr: a=Setattr [ID=0xc4 Node=0xe Uid=99 Gid=100 Pid=610] atime=2020-12-27 00:58:05.376145022 +0530 IST mtime=2020-12-27 00:58:06.380347038 +0530 IST handle=INVALID-0x0
2020/12/27 00:58:06 DEBUG : 100MB.bin: >Setattr: err=
2020/12/27 00:58:06 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:06 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:06 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=0
2020/12/27 00:58:06 DEBUG : 100MB.bin: waiting for in-sequence write to 0 for 1s
2020/12/27 00:58:07 DEBUG : 100MB.bin: aborting in-sequence write wait, off=0
2020/12/27 00:58:07 DEBUG : 100MB.bin: failed to wait for in-sequence write to 0
2020/12/27 00:58:07 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:07 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:07 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:07 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:07 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=1048576
2020/12/27 00:58:07 DEBUG : 100MB.bin: waiting for in-sequence write to 1048576 for 1s
2020/12/27 00:58:07 DEBUG : /: Attr:
2020/12/27 00:58:07 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:07 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:07 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:07 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:07 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:08 DEBUG : 100MB.bin: aborting in-sequence write wait, off=1048576
2020/12/27 00:58:08 DEBUG : 100MB.bin: failed to wait for in-sequence write to 1048576
2020/12/27 00:58:08 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:08 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:08 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=2097152
2020/12/27 00:58:08 DEBUG : 100MB.bin: waiting for in-sequence write to 2097152 for 1s
2020/12/27 00:58:09 DEBUG : 100MB.bin: aborting in-sequence write wait, off=2097152
2020/12/27 00:58:09 DEBUG : 100MB.bin: failed to wait for in-sequence write to 2097152
2020/12/27 00:58:09 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:09 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:09 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=3145728
2020/12/27 00:58:09 DEBUG : 100MB.bin: waiting for in-sequence write to 3145728 for 1s
2020/12/27 00:58:10 DEBUG : 100MB.bin: aborting in-sequence write wait, off=3145728
2020/12/27 00:58:10 DEBUG : 100MB.bin: failed to wait for in-sequence write to 3145728
2020/12/27 00:58:10 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:10 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:10 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=4194304
2020/12/27 00:58:10 DEBUG : 100MB.bin: waiting for in-sequence write to 4194304 for 1s
2020/12/27 00:58:11 DEBUG : 100MB.bin: aborting in-sequence write wait, off=4194304
2020/12/27 00:58:11 DEBUG : 100MB.bin: failed to wait for in-sequence write to 4194304
2020/12/27 00:58:11 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:11 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:11 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=5242880
2020/12/27 00:58:11 DEBUG : 100MB.bin: waiting for in-sequence write to 5242880 for 1s
2020/12/27 00:58:12 DEBUG : 100MB.bin: aborting in-sequence write wait, off=5242880
2020/12/27 00:58:12 DEBUG : 100MB.bin: failed to wait for in-sequence write to 5242880
2020/12/27 00:58:12 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:12 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:12 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=6291456
2020/12/27 00:58:12 DEBUG : 100MB.bin: waiting for in-sequence write to 6291456 for 1s
2020/12/27 00:58:13 DEBUG : 100MB.bin: aborting in-sequence write wait, off=6291456
2020/12/27 00:58:13 DEBUG : 100MB.bin: failed to wait for in-sequence write to 6291456
2020/12/27 00:58:13 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:13 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:13 DEBUG : &{100MB.bin (w)}: Write: len=131072, offset=7340032
2020/12/27 00:58:13 DEBUG : 100MB.bin: waiting for in-sequence write to 7340032 for 1s
2020/12/27 00:58:14 DEBUG : 100MB.bin: aborting in-sequence write wait, off=7340032
2020/12/27 00:58:14 DEBUG : 100MB.bin: failed to wait for in-sequence write to 7340032
2020/12/27 00:58:14 ERROR : 100MB.bin: WriteFileHandle.Write: can't seek in file without --vfs-cache-mode >= writes
2020/12/27 00:58:14 DEBUG : &{100MB.bin (w)}: >Write: written=0, err=illegal seek
2020/12/27 00:58:14 DEBUG : 100MB.bin: Attr:
2020/12/27 00:58:14 DEBUG : 100MB.bin: >Attr: a=valid=1s ino=0 size=1 mode=-rw-rw-r--, err=
2020/12/27 00:58:14 DEBUG : /: Attr:
2020/12/27 00:58:14 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:14 DEBUG : /: Remove: name="100MB.bin"
2020/12/27 00:58:14 DEBUG : 100MB.bin: Remove:
2020/12/27 00:58:14 DEBUG : : Added virtual directory entry vDel: "100MB.bin"
2020/12/27 00:58:14 DEBUG : 100MB.bin: >Remove: err=
2020/12/27 00:58:14 DEBUG : /: >Remove: err=
2020/12/27 00:58:14 DEBUG : &{100MB.bin (w)}: Flush:
2020/12/27 00:58:14 DEBUG : Google drive root '': File to upload is small (1 bytes), uploading instead of streaming
2020/12/27 00:58:16 DEBUG : 100MB.bin: MD5 = 93b885adfe0da089cdf634904fd59f71 OK
2020/12/27 00:58:16 INFO : 100MB.bin: Copied (new)
2020/12/27 00:58:17 DEBUG : 100MB.bin: Applied pending mod time 2020-12-27 00:58:06.380347038 +0530 IST OK
2020/12/27 00:58:17 DEBUG : : Added virtual directory entry vAdd: "100MB.bin"
2020/12/27 00:58:17 DEBUG : &{100MB.bin (w)}: >Flush: err=
2020/12/27 00:58:17 DEBUG : &{100MB.bin (w)}: Release:
2020/12/27 00:58:17 DEBUG : 100MB.bin: WriteFileHandle.Release nothing to do
2020/12/27 00:58:17 DEBUG : &{100MB.bin (w)}: >Release: err=
2020/12/27 00:58:17 DEBUG : /: Attr:
2020/12/27 00:58:17 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:17 DEBUG : : Statfs:
2020/12/27 00:58:17 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2020/12/27 00:58:17 DEBUG : : Statfs:
2020/12/27 00:58:17 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2020/12/27 00:58:24 DEBUG : /: Attr:
2020/12/27 00:58:24 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:47 DEBUG : /: Attr:
2020/12/27 00:58:47 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=
2020/12/27 00:58:51 DEBUG : Google drive root '': Checking for changes on remote
2020/12/27 00:58:51 DEBUG : : changeNotify: relativePath="100MB.bin", type=3
2020/12/27 00:58:51 DEBUG : : invalidating directory cache
2020/12/27 00:58:51 DEBUG : : >changeNotify:
2020/12/27 00:59:51 DEBUG : Google drive root '': Checking for changes on remote
2020/12/27 01:00:51 DEBUG : Google drive root '': Checking for changes on remote
2020/12/27 01:01:02 DEBUG : /: Attr:
2020/12/27 01:01:02 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=

Yes, I have mentioned this also into my first post. But it has one issue as well which I wanted to bring to @ncw and others.

It only works if the file size is less than 7GB, anything more than 7GB and it fails to work. It stops the process.

If there is some solution for this, let me know.

Let's suppose. If the file size is 100MB, it will work fine.

But if the file size is 10GB, it will copy the file upto the 7GB and then stops it and deletes the file.

windows cannot write to the rclone mount as the command is missing --vfs-cache-mode, thus that error.
so add --vfs-cache-mode=full to your command and test again

I just told you, Please read : [unraid] rclone Permission and writefilehandle.write Issue - #15 by alexjohn

Yes, I have mentioned this also into my first post. But it has one issue as well which I wanted to bring to @ncw and others.

It only works if the file size is less than 7GB, anything more than 7GB and it fails to work. It stops the process.

If there is some solution for this, let me know.

Let's suppose. If the file size is 100MB, it will work fine.

But if the file size is 10GB, it will copy the file upto the 7GB and then stops it and deletes the file.

You are telling me something which I already know. But with --vfs-cache-mode=full I am facing the issue as mentioned in the quote above.

It only works for the files which are less than 7GB. It doesn't work for the files which are more than 7GB.

As I mentioned a few posts above, putting Samba on put of rclone is just not a great idea as you have to understand how Samba works as well.

If it's writing a larger file, it requires vfs-cache-mode writes. There is nothing rclone can do to fix that other than enable vfs-cache-mode writes.

It isn't a bug/problem/deficiency with rclone as it's just how Samba works when writing a file.

There is no other setting to change or adjust in rclone to fix this.

1 Like

But it is partially fixing. With --vfs-cache-mode writes

Any file more than 7GB in size, fails to copy and just stops copying. Is that normal?

Like, If the file size is 10GB, it will copy the file till 7GB and once it reaches 7GB, it stops copying and deletes the file.

This is happening outside of SAMBA also. It is the same thing happening in Linux environment also.

Anything more than 7GB, it fails.

If you can reproduce the issue with a debug log file on Linux without Samba, please share the full debug log and the steps you executed to recreate the issue as it works fine with any of the other modes and you only enable full or writes if the program/process writing requires it which is noted by the debug log.

felix@gemini:~$ cd /data
felix@gemini:/data$ fallocate -l 10G test.out
felix@gemini:/data$ du -sh test.out
10G     test.out
felix@gemini:/data$ cp test.out /GD
felix@gemini:/data$ cd /GD
felix@gemini:/GD$ ls -al
total 10485761
-rw-rw-r-- 1 felix felix 10737418240 Dec 27 11:23 test.out
felix@gemini:/GD$ du -sh test.out
10G     test.out
felix@gemini:/GD$ ps -ef | grep rclone | grep GD
felix        880       1  9 Dec23 ?        09:04:33 /usr/bin/rclone mount gcrypt: /GD --allow-other --dir-cache-time 1000h --log-level NOTICE --log-file /opt/rclone/logs/rclone.log --poll-interval 15s --umask 002 --user-agent randomappname101 --rc --rc-addr :5572 --rc-no-auth --cache-dir=/cache --vfs-cache-mode full --vfs-cache-max-size 500G --vfs-cache-max-age 336h --bwlimit-file 16M

There's a 10GB file copied with no issues.

1 Like

Hello, I am replicating the issue in the Linux Environment (without Samba). Could you please tell me the "please share the full debug log", How to do so?

I am using -vv though.

Thanks.

Use -vv and use --log-file and share the log via pastebin/drivelink/however you want to share it.

1 Like

Okay, @Animosity022 I have added the --vfs-cache-mode writes into my command.

Command Now: rclone mount --allow-other --buffer-size 256M --dir-cache-time 96h --timeout 1h --default-permissions --fast-list --uid 99 --gid 100 --umask 002 -vv --vfs-cache-mode writes --log-file /mnt/disks/ua_hdd1/rclone.log gdrive: /mnt/disks/ua_hdd1/gdrive &

Steps/Process Below:

I have added the 10GB.bin file for testing here: /mnt/disks/ua_hdd1/

Now, I am going to copy this 10GB.bin file from the above mentioned path to the rclone mount of Google Drive i.e.: /mnt/disks/ua_hdd1/gdrive

root@unraid:~# cd /mnt/disks/ua_hdd1/
root@unraid:/mnt/disks/ua_hdd1# ls
10GB.bin  command.txt  downloads/  gdrive/  others/  rclone.log
root@unraid:/mnt/disks/ua_hdd1# cp 10GB.bin /mnt/disks/ua_hdd1/gdrive

It is copying the file to the location right now. Stops copying around 7GB

cp: error writing '/mnt/disks/ua_hdd1/gdrive/10GB.bin': Input/output error
root@unraid:/mnt/disks/ua_hdd1# 

When I do ls -la, it gives below output

root@unraid:/mnt/disks/ua_hdd1# cd gdrive
root@unraid:/mnt/disks/ua_hdd1/gdrive# ls -la
-rw-rw-r-- 1 nobody users 7512698880 Dec 27 22:18 10GB.bin

Log File: https://www.dropbox.com/s/b3eky57kvefipdh/rclone1.log?dl=0

Please check and let me know, if there is some issue, I will re-do everything. Please assist. Thanks.

You run out of space on your mount point you are copying to, so it fails:

2020/12/27 22:14:12 DEBUG : 10GB.bin(0xc0000be580): _writeAt: size=131072, off=7512653824
2020/12/27 22:14:12 DEBUG : 10GB.bin(0xc0000be580): >_writeAt: n=0, err=write /root/.cache/rclone/vfs/gdrive/10GB.bin: no space left on device
2020/12/27 22:14:12 DEBUG : &{10GB.bin (rw)}: >Write: written=0, err=write /root/.cache/rclone/vfs/gdrive/10GB.bin: no space left on device
1 Like

Okay, I have actually mounted the Google Drive on a 1TB Hard Disk, which shouldn't run out of the space.

Here is the Hard Disk:

It has more than 900GB Space left.

Please assist me with the solution. Thanks.

You need to specify a location for the cache that has enough space to store a 10GB file:

2020/12/27 22:07:08 DEBUG : vfs cache: root is "/root/.cache/rclone/vfs/gdrive"
2020/12/27 22:07:08 DEBUG : vfs cache: metadata root is "/root/.cache/rclone/vfs/gdrive"

Use --cache-dir and point it wherever you want to store cache files as your /root doesn't have 10GB of space.

1 Like

Okay, I have changed the cache dir to /mnt/disks/ua_hdd1/rclone/cache

Command Now: rclone mount --allow-other --buffer-size 256M --dir-cache-time 96h --timeout 1h --default-permissions --fast-list --uid 99 --gid 100 --umask 002 -vv --vfs-cache-mode writes --log-file /mnt/disks/ua_hdd1/rclone.log --cache-dir /mnt/disks/ua_hdd1/rclone/cache gdrive: /mnt/disks/ua_hdd1/gdrive &

I'm now going to do the test and see if it fails or works.....

Okay, It worked fine. No Error. Thanks for that. But, I have some more questions if you don't mind?

  1. Is there anything you suggest adding (flags/commands) to this setup to improve the performance and overall robust-ness?

  2. How can I make sure the cache director is cleaned once the work is done?

  3. Is there any other flags which makes sure, I don't have any issue because of the cache again?

  4. Anything else you wish to tell which I might have forgot to ask?

Thanks.

--fast-list does nothing and can be removed.
--buffer-size - any reason you are setting it? You should remove it.

You can turn off -vv once you are confident things are working. More is less. Use the defaults unless you have a reason to not use them.

It cleans itself and there is nothing you need to do. If you want to change any of the times, please check here:

1 Like

Okay, I have made the changes. But regarding, Buffer Size.

My Media Consumption Process:

I download my media from Sonarr/Radarr (via. Torrent/NZB) to Local HDD and then Sonarr/Radarr copies the file directly to the Mounted Gdrive (via. rclone).

Now, I use Plex to watch the Media, so I have been using Gdrive/media/shows and Gdrive/media/movies directly onto the Plex.

So, If I play a movie, it downloads from the Google's Server directly.

  1. So if you have any better flags/commands to improve this whole setup let me know?
  2. Do I need buffer-size flag for this?
  3. I have been wondering one thing for a long-time. How can I do this? (Mentioned Below)

Each time, when I play a media on the Plex, it loads from the Google's Server, right?

How can I make sure, I don't have to re-load the media for x-duration even if I turn off the Plex for the day?

Like, I am watching Tenet. I watched the movie till 1 Hour, but now I wish to watch next 1 hour tomorrow. But, Plex buffers the media for n number of minutes in advance for me, How can I make sure, I retain those n number of minutes for x duration? So that, when I re-launch/resume the Plex, it don't have to redownload?

I hope I am able to explain this.

Thanks.