Can't copy large files (>500MB) to mounted MS OneDrive in macOS Sierra


#1

I’ve just started using rclone, so I don’t have a lot of experience with it.
I’m trying to mount a MS OneDrive account into macOS Sierra. In principle everything works fine. I can mount the onedrive and can access it within the finder. I can copy files to it and from it. The problem is, that I can only copy files upon a particular size (approx 400MB). If I copy a file larger than that (e.g. 500MB), after a few minutes of copying I get the Finder error “The Finder can’t complete the operation because some data in “500MB” can’t be read or written. (Error code -36)”
Copying large files with the command “rclone copy /home/source remote:backup” works fine, no problems there.

I found a few threads in the rclone forum about this issue (error code -36) but nothing really helped. I tried a lot of different rclone options for a few hours with no success.

I can’t upgrade macOS since I have to install rclone on about 100 devices which all run Sierra.

Do you have any idea what I’m doing wrong?

Any help is very appreciated.

Here is my setup:

  • Installed today an absolutely fresh and clean install of macOS 10.12.6 (Sierra) with all patches available.
  • No other software installed, all settings of the OS were left at the defaults.
  • System Integrity Protection status: disabled.
  • FUSE 3.8.2
  • rclone 1.45
  • Added 1 remote (MS OneDrive)
  • Started rclone with: rclone -vv --vfs-cache-mode writes mount onedrive: ~/OneDrive
  • Tried to copy 1 File “500MB” to onedrive. Starts normally, after approx 3 minutes said Finder error occurs. rclone seems to quit itself.

Attached you will find the logfile. I removed some lines in the middle since the text exceeded the allowed maximum size here in the forum.

Last login: Sun Dec 2 11:21:04 on console
Users-iMac:~ user$ rclone -vv --vfs-cache-mode writes mount onedrive: ~/OneDrive
2018/12/02 11:21:23 DEBUG : rclone: Version “v1.45” starting with parameters [“rclone” “-vv” “–vfs-cache-mode” “writes” “mount” “onedrive:” “/Users/user/OneDrive”]
2018/12/02 11:21:23 DEBUG : Using config file from “/Users/user/.config/rclone/rclone.conf”
2018/12/02 11:21:23 DEBUG : One drive root ‘’: Mounting on “/Users/user/OneDrive”
2018/12/02 11:21:23 INFO : One drive root ‘’: poll-interval is not supported by this remote
2018/12/02 11:21:23 DEBUG : vfs cache root is “/Users/user/Library/Caches/rclone/vfs/onedrive”
2018/12/02 11:21:23 DEBUG : Adding path “vfs/forget” to remote control registry
2018/12/02 11:21:23 DEBUG : Adding path “vfs/refresh” to remote control registry
2018/12/02 11:21:23 DEBUG : Adding path “vfs/poll-interval” to remote control registry
2018/12/02 11:21:23 DEBUG : Cleaning the cache
2018/12/02 11:21:23 DEBUG : : Root:
2018/12/02 11:21:23 DEBUG : : >Root: node=/, err=
2018/12/02 11:21:23 DEBUG : 500MB: updateTime: setting atime to 2018-12-02 11:15:13 +0100 CET
2018/12/02 11:21:23 DEBUG : : Statfs:
2018/12/02 11:21:23 DEBUG : : Statfs:
2018/12/02 11:21:23 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : /: Attr:
2018/12/02 11:21:24 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:24 DEBUG : : Statfs:
2018/12/02 11:21:24 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:27 DEBUG : /: Attr:
2018/12/02 11:21:27 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=".hidden"
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=, err=no such file or directory
2018/12/02 11:21:27 DEBUG : /: ReadDirAll:
2018/12/02 11:21:27 DEBUG : /: >ReadDirAll: item=9, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=“1”
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=1/, err=
2018/12/02 11:21:27 DEBUG : 1/: Attr:
2018/12/02 11:21:27 DEBUG : 1/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=“100MB”
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=100MB, err=
2018/12/02 11:21:27 DEBUG : 100MB: Attr:
2018/12/02 11:21:27 DEBUG : 100MB: >Attr: a=valid=1s ino=0 size=104857600 mode=-rw-r–r--, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=“2”
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=2/, err=
2018/12/02 11:21:27 DEBUG : 2/: Attr:
2018/12/02 11:21:27 DEBUG : 2/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=“3”
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=3/, err=
2018/12/02 11:21:27 DEBUG : 3/: Attr:
2018/12/02 11:21:27 DEBUG : 3/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=“300MB”
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=300MB, err=
2018/12/02 11:21:27 DEBUG : 300MB: Attr:
2018/12/02 11:21:27 DEBUG : 300MB: >Attr: a=valid=1s ino=0 size=314572800 mode=-rw-r–r--, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=“4”
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=4/, err=
2018/12/02 11:21:27 DEBUG : 4/: Attr:
2018/12/02 11:21:27 DEBUG : 4/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=“5”
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=5/, err=
2018/12/02 11:21:27 DEBUG : 5/: Attr:
2018/12/02 11:21:27 DEBUG : 5/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=“6”
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=6/, err=
2018/12/02 11:21:27 DEBUG : 6/: Attr:
2018/12/02 11:21:27 DEBUG : 6/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:27 DEBUG : /: Lookup: name=“Dokumente”
2018/12/02 11:21:27 DEBUG : /: >Lookup: node=Dokumente/, err=
2018/12/02 11:21:27 DEBUG : Dokumente/: Attr:
2018/12/02 11:21:27 DEBUG : Dokumente/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:27 DEBUG : : Statfs:
2018/12/02 11:21:27 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:27 DEBUG : /: Attr:
2018/12/02 11:21:27 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:27 DEBUG : : Statfs:
2018/12/02 11:21:27 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:27 DEBUG : : Statfs:
2018/12/02 11:21:27 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:27 DEBUG : /: Attr:
2018/12/02 11:21:27 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:28 DEBUG : /: ReadDirAll:
2018/12/02 11:21:28 DEBUG : /: >ReadDirAll: item=9, err=
2018/12/02 11:21:28 DEBUG : : Statfs:
2018/12/02 11:21:28 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:30 DEBUG : 6/: Attr:
2018/12/02 11:21:30 DEBUG : 6/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:30 DEBUG : 6/: ReadDirAll:
2018/12/02 11:21:30 DEBUG : 6/: >ReadDirAll: item=0, err=
2018/12/02 11:21:30 DEBUG : 6/: ReadDirAll:
2018/12/02 11:21:30 DEBUG : 6/: >ReadDirAll: item=0, err=
2018/12/02 11:21:30 DEBUG : 6/: ReadDirAll:
2018/12/02 11:21:30 DEBUG : 6/: >ReadDirAll: item=0, err=
2018/12/02 11:21:30 DEBUG : : Statfs:
2018/12/02 11:21:30 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:30 DEBUG : /: Attr:
2018/12/02 11:21:30 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:30 DEBUG : 6/: Attr:
2018/12/02 11:21:30 DEBUG : 6/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:30 DEBUG : : Statfs:
2018/12/02 11:21:30 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:30 DEBUG : : Statfs:
2018/12/02 11:21:30 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:30 DEBUG : 6/: Attr:
2018/12/02 11:21:30 DEBUG : 6/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:33 DEBUG : /: Attr:
2018/12/02 11:21:33 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:33 DEBUG : : Statfs:
2018/12/02 11:21:33 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:33 DEBUG : 6/: Attr:
2018/12/02 11:21:33 DEBUG : 6/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=
2018/12/02 11:21:33 DEBUG : : Statfs:
2018/12/02 11:21:33 DEBUG : : >Statfs: stat={Blocks:1310720 Bfree:773114 Bavail:773113 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=
2018/12/02 11:21:33 DEBUG : 6/: Lookup: name=“500MB”
2018/12/02 11:21:33 DEBUG : 6/: >Lookup: node=, err=no such file or directory
2018/12/02 11:21:33 DEBUG : 6/: Lookup: name=“500MB”
2018/12/02 11:21:33 DEBUG : 6/: >Lookup: node=, err=no such file or directory
2018/12/02 11:21:33 DEBUG : 6/: Lookup: name=“500MB”
2018/12/02 11:21:33 DEBUG : 6/: >Lookup: node=, err=no such file or directory
2018/12/02 11:21:33 DEBUG : 6/: Lookup: name=“500MB”
2018/12/02 11:21:33 DEBUG : 6/: >Lookup: node=, err=no such file or directory
2018/12/02 11:21:33 DEBUG : 6/: Lookup: name=“500MB”
2018/12/02 11:21:33 DEBUG : 6/: >Lookup: node=, err=no such file or directory
2018/12/02 11:21:33 DEBUG : 6/: Create: name=“500MB”
2018/12/02 11:21:33 DEBUG : 6/500MB: Open: flags=O_RDWR|O_CREATE|O_EXCL
2018/12/02 11:21:33 DEBUG : 6/500MB(0xc000388360): Opening cached copy with flags=O_RDWR|O_CREATE|O_EXCL
2018/12/02 11:21:33 DEBUG : 6/500MB: >Open: fd=6/500MB (rw), err=
2018/12/02 11:21:33 DEBUG : 6/: >Create: node=6/500MB, handle=&{6/500MB (rw)}, err=
2018/12/02 11:21:33 DEBUG : 6/500MB: Attr:
2018/12/02 11:21:33 DEBUG : 6/500MB: >Attr: a=valid=1s ino=0 size=0 mode=-rw-r–r--, err=
2018/12/02 11:21:33 DEBUG : &{6/500MB (rw)}: Flush:
2018/12/02 11:21:33 DEBUG : 6/500MB(0xc000388360): RWFileHandle.Flush ignoring flush on unwritten handle
2018/12/02 11:21:33 DEBUG : &{6/500MB (rw)}: >Flush: err=
2018/12/02 11:21:33 DEBUG : &{6/500MB (rw)}: Release:
2018/12/02 11:21:33 DEBUG : 6/500MB(0xc000388360): RWFileHandle.Release closing
2018/12/02 11:21:33 DEBUG : 6/500MB(0xc000388360): close:
2018/12/02 11:21:33 DEBUG : 6/500MB: Couldn’t find file - need to transfer
2018/12/02 11:21:33 DEBUG : 6/500MB: Starting singlepart upload
2018/12/02 11:21:33 DEBUG : 6/: Attr:
.
.

.
.
2018/12/02 11:21:48 DEBUG : 6/500MB: >Attr: a=valid=1s ino=0 size=448790528 mode=-rw-r–r--, err=
2018/12/02 11:21:48 DEBUG : 6/500MB: Open: flags=OpenReadOnly
2018/12/02 11:21:48 DEBUG : 6/500MB: Open: flags=O_RDONLY
2018/12/02 11:21:48 DEBUG : 6/500MB: >Open: fd=6/500MB (rw), err=
2018/12/02 11:21:48 DEBUG : 6/500MB: >Open: fh=&{6/500MB (rw)}, err=
2018/12/02 11:21:48 DEBUG : &{6/500MB (rw)}: Flush:
2018/12/02 11:21:48 DEBUG : &{6/500MB (rw)}: >Flush: err=
2018/12/02 11:21:48 DEBUG : &{6/500MB (rw)}: Release:
2018/12/02 11:21:48 DEBUG : 6/500MB(0xc000389020): RWFileHandle.Release closing
2018/12/02 11:21:48 DEBUG : 6/500MB(0xc000389020): close:
2018/12/02 11:21:48 DEBUG : 6/500MB(0xc000389020): >close: err=
2018/12/02 11:21:48 DEBUG : &{6/500MB (rw)}: >Release: err=
2018/12/02 11:21:48 DEBUG : 6/500MB: Attr:
2018/12/02 11:21:48 DEBUG : 6/500MB: >Attr: a=valid=1s ino=0 size=448790528 mode=-rw-r–r--, err=
2018/12/02 11:21:48 DEBUG : 6/500MB: Open: flags=OpenReadOnly
2018/12/02 11:21:48 DEBUG : 6/500MB: Open: flags=O_RDONLY
2018/12/02 11:21:48 DEBUG : 6/500MB: >Open: fd=6/500MB (rw), err=
2018/12/02 11:21:48 DEBUG : 6/500MB: >Open: fh=&{6/500MB (rw)}, err=
2018/12/02 11:21:48 DEBUG : &{6/500MB (rw)}: Flush:
2018/12/02 11:21:48 DEBUG : &{6/500MB (rw)}: >Flush: err=
2018/12/02 11:21:48 DEBUG : &{6/500MB (rw)}: Release:
2018/12/02 11:21:48 DEBUG : 6/500MB(0xc000389080): RWFileHandle.Release closing
2018/12/02 11:21:48 DEBUG : 6/500MB(0xc000389080): close:
2018/12/02 11:21:48 DEBUG : 6/500MB(0xc000389080): >close: err=
2018/12/02 11:21:48 DEBUG : &{6/500MB (rw)}: >Release: err=
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: Write: len=16777216, offset=448790528
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: >Write: written=16777216, err=
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: Write: len=16777216, offset=465567744
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: >Write: written=16777216, err=
2018/12/02 11:21:49 DEBUG : 6/500MB: Attr:
2018/12/02 11:21:49 DEBUG : 6/500MB: >Attr: a=valid=1s ino=0 size=482344960 mode=-rw-r–r--, err=
2018/12/02 11:21:49 DEBUG : 6/500MB: Open: flags=OpenReadOnly
2018/12/02 11:21:49 DEBUG : 6/500MB: Open: flags=O_RDONLY
2018/12/02 11:21:49 DEBUG : 6/500MB: >Open: fd=6/500MB (rw), err=
2018/12/02 11:21:49 DEBUG : 6/500MB: >Open: fh=&{6/500MB (rw)}, err=
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: Flush:
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: >Flush: err=
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: Release:
2018/12/02 11:21:49 DEBUG : 6/500MB(0xc0003891a0): RWFileHandle.Release closing
2018/12/02 11:21:49 DEBUG : 6/500MB(0xc0003891a0): close:
2018/12/02 11:21:49 DEBUG : 6/500MB(0xc0003891a0): >close: err=
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: >Release: err=
2018/12/02 11:21:49 DEBUG : 6/500MB: Attr:
2018/12/02 11:21:49 DEBUG : 6/500MB: >Attr: a=valid=1s ino=0 size=482344960 mode=-rw-r–r--, err=
2018/12/02 11:21:49 DEBUG : 6/500MB: Open: flags=OpenReadOnly
2018/12/02 11:21:49 DEBUG : 6/500MB: Open: flags=O_RDONLY
2018/12/02 11:21:49 DEBUG : 6/500MB: >Open: fd=6/500MB (rw), err=
2018/12/02 11:21:49 DEBUG : 6/500MB: >Open: fh=&{6/500MB (rw)}, err=
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: Flush:
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: >Flush: err=
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: Release:
2018/12/02 11:21:49 DEBUG : 6/500MB(0xc000389200): RWFileHandle.Release closing
2018/12/02 11:21:49 DEBUG : 6/500MB(0xc000389200): close:
2018/12/02 11:21:49 DEBUG : 6/500MB(0xc000389200): >close: err=
2018/12/02 11:21:49 DEBUG : &{6/500MB (rw)}: >Release: err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: Write: len=16777216, offset=482344960
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: >Write: written=16777216, err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: Write: len=16777216, offset=499122176
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: >Write: written=16777216, err=
2018/12/02 11:21:50 DEBUG : 6/500MB: Attr:
2018/12/02 11:21:50 DEBUG : 6/500MB: >Attr: a=valid=1s ino=0 size=515899392 mode=-rw-r–r--, err=
2018/12/02 11:21:50 DEBUG : 6/500MB: Open: flags=OpenReadOnly
2018/12/02 11:21:50 DEBUG : 6/500MB: Open: flags=O_RDONLY
2018/12/02 11:21:50 DEBUG : 6/500MB: >Open: fd=6/500MB (rw), err=
2018/12/02 11:21:50 DEBUG : 6/500MB: >Open: fh=&{6/500MB (rw)}, err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: Flush:
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: >Flush: err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: Release:
2018/12/02 11:21:50 DEBUG : 6/500MB(0xc000389320): RWFileHandle.Release closing
2018/12/02 11:21:50 DEBUG : 6/500MB(0xc000389320): close:
2018/12/02 11:21:50 DEBUG : 6/500MB(0xc000389320): >close: err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: >Release: err=
2018/12/02 11:21:50 DEBUG : 6/500MB: Attr:
2018/12/02 11:21:50 DEBUG : 6/500MB: >Attr: a=valid=1s ino=0 size=515899392 mode=-rw-r–r--, err=
2018/12/02 11:21:50 DEBUG : 6/500MB: Open: flags=OpenReadOnly
2018/12/02 11:21:50 DEBUG : 6/500MB: Open: flags=O_RDONLY
2018/12/02 11:21:50 DEBUG : 6/500MB: >Open: fd=6/500MB (rw), err=
2018/12/02 11:21:50 DEBUG : 6/500MB: >Open: fh=&{6/500MB (rw)}, err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: Flush:
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: >Flush: err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: Release:
2018/12/02 11:21:50 DEBUG : 6/500MB(0xc000389380): RWFileHandle.Release closing
2018/12/02 11:21:50 DEBUG : 6/500MB(0xc000389380): close:
2018/12/02 11:21:50 DEBUG : 6/500MB(0xc000389380): >close: err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: >Release: err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: Write: len=8388608, offset=515899392
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: >Write: written=8388608, err=
2018/12/02 11:21:50 DEBUG : 6/500MB: Attr:
2018/12/02 11:21:50 DEBUG : 6/500MB: >Attr: a=valid=1s ino=0 size=524288000 mode=-rw-r–r--, err=
2018/12/02 11:21:50 DEBUG : &{6/500MB (rw)}: Flush:
2018/12/02 11:21:50 DEBUG : 6/500MB(0xc0001490e0): close:
2018/12/02 11:21:50 DEBUG : 6/500MB: Couldn’t find file - need to transfer
2018/12/02 11:21:50 DEBUG : 6/500MB: Starting multipart upload
2018/12/02 11:21:51 DEBUG : 6/500MB: Uploading segment 0/524288000 size 10485760
2018/12/02 11:21:53 DEBUG : 6/500MB: Uploading segment 10485760/524288000 size 10485760
2018/12/02 11:21:56 DEBUG : 6/500MB: Uploading segment 20971520/524288000 size 10485760
2018/12/02 11:22:00 DEBUG : 6/500MB: Uploading segment 31457280/524288000 size 10485760
2018/12/02 11:22:03 DEBUG : 6/500MB: Uploading segment 41943040/524288000 size 10485760
2018/12/02 11:22:06 DEBUG : 6/500MB: Uploading segment 52428800/524288000 size 10485760
2018/12/02 11:22:09 DEBUG : 6/500MB: Uploading segment 62914560/524288000 size 10485760
2018/12/02 11:22:12 DEBUG : 6/500MB: Uploading segment 73400320/524288000 size 10485760
2018/12/02 11:22:15 DEBUG : 6/500MB: Uploading segment 83886080/524288000 size 10485760
2018/12/02 11:22:17 DEBUG : 6/500MB: Uploading segment 94371840/524288000 size 10485760
2018/12/02 11:22:21 DEBUG : 6/500MB: Uploading segment 104857600/524288000 size 10485760
2018/12/02 11:22:23 DEBUG : Cleaning the cache
2018/12/02 11:22:23 DEBUG : 6/500MB: updateTime: setting atime to 2018-12-02 11:22:23 +0100 CET
2018/12/02 11:22:24 DEBUG : 6/500MB: Uploading segment 115343360/524288000 size 10485760
2018/12/02 11:22:27 DEBUG : 6/500MB: Uploading segment 125829120/524288000 size 10485760
2018/12/02 11:22:30 DEBUG : 6/500MB: Uploading segment 136314880/524288000 size 10485760
2018/12/02 11:22:33 DEBUG : 6/500MB: Uploading segment 146800640/524288000 size 10485760
2018/12/02 11:22:35 DEBUG : 6/500MB: Uploading segment 157286400/524288000 size 10485760
2018/12/02 11:22:38 DEBUG : 6/500MB: Uploading segment 167772160/524288000 size 10485760
2018/12/02 11:22:41 DEBUG : 6/500MB: Uploading segment 178257920/524288000 size 10485760
2018/12/02 11:22:43 DEBUG : 6/500MB: Uploading segment 188743680/524288000 size 10485760
2018/12/02 11:22:45 DEBUG : 6/500MB: Uploading segment 199229440/524288000 size 10485760
2018/12/02 11:22:48 DEBUG : 6/500MB: Uploading segment 209715200/524288000 size 10485760
2018/12/02 11:22:51 DEBUG : 6/500MB: Uploading segment 220200960/524288000 size 10485760
2018/12/02 11:22:54 DEBUG : 6/500MB: Uploading segment 230686720/524288000 size 10485760
2018/12/02 11:22:57 DEBUG : 6/500MB: Uploading segment 241172480/524288000 size 10485760
2018/12/02 11:23:00 DEBUG : 6/500MB: Uploading segment 251658240/524288000 size 10485760
2018/12/02 11:23:03 DEBUG : 6/500MB: Uploading segment 262144000/524288000 size 10485760
2018/12/02 11:23:06 DEBUG : 6/500MB: Uploading segment 272629760/524288000 size 10485760
2018/12/02 11:23:09 DEBUG : 6/500MB: Uploading segment 283115520/524288000 size 10485760
2018/12/02 11:23:12 DEBUG : 6/500MB: Uploading segment 293601280/524288000 size 10485760
2018/12/02 11:23:15 DEBUG : 6/500MB: Uploading segment 304087040/524288000 size 10485760
2018/12/02 11:23:17 DEBUG : 6/500MB: Uploading segment 314572800/524288000 size 10485760
2018/12/02 11:23:20 DEBUG : 6/500MB: Uploading segment 325058560/524288000 size 10485760
2018/12/02 11:23:23 DEBUG : 6/500MB: Uploading segment 335544320/524288000 size 10485760
2018/12/02 11:23:23 DEBUG : Cleaning the cache
2018/12/02 11:23:23 DEBUG : 6/500MB: updateTime: setting atime to 2018-12-02 11:23:23 +0100 CET
2018/12/02 11:23:26 DEBUG : 6/500MB: Uploading segment 346030080/524288000 size 10485760
2018/12/02 11:23:29 DEBUG : 6/500MB: Uploading segment 356515840/524288000 size 10485760
2018/12/02 11:23:32 DEBUG : 6/500MB: Uploading segment 367001600/524288000 size 10485760
2018/12/02 11:23:35 DEBUG : 6/500MB: Uploading segment 377487360/524288000 size 10485760
2018/12/02 11:23:38 DEBUG : 6/500MB: Uploading segment 387973120/524288000 size 10485760
2018/12/02 11:23:40 DEBUG : 6/500MB: Uploading segment 398458880/524288000 size 10485760
2018/12/02 11:23:43 DEBUG : 6/500MB: Uploading segment 408944640/524288000 size 10485760
2018/12/02 11:23:46 DEBUG : 6/500MB: Uploading segment 419430400/524288000 size 10485760
2018/12/02 11:23:49 DEBUG : 6/500MB: Uploading segment 429916160/524288000 size 10485760
2018/12/02 11:23:52 DEBUG : 6/500MB: Uploading segment 440401920/524288000 size 10485760
2018/12/02 11:23:54 DEBUG : 6/500MB: Uploading segment 450887680/524288000 size 10485760
2018/12/02 11:23:57 DEBUG : 6/500MB: Uploading segment 461373440/524288000 size 10485760
2018/12/02 11:24:00 DEBUG : 6/500MB: Uploading segment 471859200/524288000 size 10485760
2018/12/02 11:24:03 DEBUG : 6/500MB: Uploading segment 482344960/524288000 size 10485760
2018/12/02 11:24:06 DEBUG : 6/500MB: Uploading segment 492830720/524288000 size 10485760
2018/12/02 11:24:09 DEBUG : 6/500MB: Uploading segment 503316480/524288000 size 10485760
2018/12/02 11:24:12 DEBUG : 6/500MB: Uploading segment 513802240/524288000 size 10485760
2018/12/02 11:24:15 INFO : 6/500MB: Copied (new)
2018/12/02 11:24:15 DEBUG : 6/500MB: transferred to remote
2018/12/02 11:24:15 DEBUG : 6/500MB(0xc0001490e0): >close: err=
2018/12/02 11:24:15 DEBUG : &{6/500MB (rw)}: >Flush: err=
2018/12/02 11:24:15 DEBUG : rclone: Version “v1.45” finishing with parameters [“rclone” “-vv” “–vfs-cache-mode” “writes” “mount” “onedrive:” “/Users/user/OneDrive”]
Users-iMac:~ user$


#2

Try setting this to longer than it takes to upload the largest file you want to upload

  --daemon-timeout duration            Time limit for rclone to respond to kernel (not supported by all OSes).

#3

You’re right, after using the parameter ‘–daemon-timeout 120m’ I could successfully upload a 3GB file.
Thank you very much for your help!


#4

Great :smile:

This could do with a note in the docs I think…

Do you fancy sending a pull request to this file with a new section “macOS caveats” and a description of the problem and the solution?