Rclone with box.com using ftp protocol

Help and Support
1

What is the problem you are having with rclone?

I try to open the file, but the file doesn't open

i believe this is the problem, but i have no idea how to fix it:

2022/01/07 15:55:09 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.Read seek close old failed: 551 Box: Partial-file downloads are not supported.

Run the command 'rclone version' and share the full output of the command.

rclone v1.57.0

  • os/version: ubuntu 18.04 (64 bit)
  • os/kernel: 4.15.0-166-generic (x86_64)
  • os/type: linux
  • os/arch: amd64
  • go/version: go1.17.2
  • go/linking: static
  • go/tags: none

Which cloud storage system are you using? (eg Google Drive)

The command you were trying to run (eg rclone copy /tmp remote:tmp)

rclone mount --daemon boxftp:/ --allow-other /var/www/html/storage777

The rclone config contents with secrets removed.

[boxftp]
type = ftp
host = ftp.box.com
user = *REDACTED*
pass = *REDACTED*
tls = true
port = 990 // this is a comment: i also have tried on port 21.

A log from the command with the -vv flag

BY DELETING THIS COMMENT, I AM CONFIRMING I HAVE READ THIS AND WILL USE THE TEMPLATE BELOW FOR MY POST.

What is the problem you are having with rclone?

I try to open the file, but the file doesn't open

Run the command 'rclone version' and share the full output of the command.

rclone v1.57.0

  • os/version: ubuntu 18.04 (64 bit)
  • os/kernel: 4.15.0-166-generic (x86_64)
  • os/type: linux
  • os/arch: amd64
  • go/version: go1.17.2
  • go/linking: static
  • go/tags: none

Which cloud storage system are you using? (eg Google Drive)

The command you were trying to run (eg rclone copy /tmp remote:tmp)

rclone mount --daemon boxftp:/ --allow-other /var/www/html/storage777

The rclone config contents with secrets removed.

[boxftp]
type = ftp
host = ftp.box.com
user = *REDACTED*
pass = *REDACTED*
tls = true
port = 990 // this is a comment: i also have tried on port 21.

A log from the command with the -vv flag

2022/01/07 15:54:31 DEBUG : rclone: Version "v1.57.0" starting with parameters ["rclone" "mount" "-vvv" "--daemon" "boxftp:/" "--allow-other" "/var/www/html/storage777" "--log-file" "/root/rclone.log"]
2022/01/07 15:54:31 DEBUG : Creating backend with remote "boxftp:/"
2022/01/07 15:54:31 DEBUG : Using config file from "/root/.config/rclone/rclone.conf"
2022/01/07 15:54:31 DEBUG : ftps://ftp.box.com:990: Connecting to FTP server
2022/01/07 15:54:34 DEBUG : rclone: Version "v1.57.0" starting with parameters ["/usr/bin/rclone" "mount" "-vvv" "--daemon" "boxftp:/" "--allow-other" "/var/www/html/storage777" "--log-file" "/root/rclone.log"]
2022/01/07 15:54:34 DEBUG : Creating backend with remote "boxftp:/"
2022/01/07 15:54:34 DEBUG : Using config file from "/root/.config/rclone/rclone.conf"
2022/01/07 15:54:34 DEBUG : ftps://ftp.box.com:990: Connecting to FTP server
2022/01/07 15:54:35 INFO  : ftps://ftp.box.com:990: poll-interval is not supported by this remote
2022/01/07 15:54:35 DEBUG : ftps://ftp.box.com:990: Mounting on "/var/www/html/storage777"
2022/01/07 15:54:35 DEBUG : : Root: 
2022/01/07 15:54:35 DEBUG : : >Root: node=/, err=<nil>
2022/01/07 15:54:35 DEBUG : rclone: Version "v1.57.0" finishing with parameters ["/usr/bin/rclone" "mount" "-vvv" "--daemon" "boxftp:/" "--allow-other" "/var/www/html/storage777" "--log-file" "/root/rclone.log"]
2022/01/07 15:54:39 DEBUG : /: Lookup: name="movies"
2022/01/07 15:54:39 DEBUG : /: >Lookup: node=movies/, err=<nil>
2022/01/07 15:54:39 DEBUG : movies/: Attr: 
2022/01/07 15:54:39 DEBUG : movies/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=<nil>
2022/01/07 15:54:39 DEBUG : movies/: Lookup: name="lancamentos2020"
2022/01/07 15:54:40 DEBUG : movies/: >Lookup: node=movies/lancamentos2020/, err=<nil>
2022/01/07 15:54:40 DEBUG : movies/lancamentos2020/: Attr: 
2022/01/07 15:54:40 DEBUG : movies/lancamentos2020/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=<nil>
2022/01/07 15:54:40 DEBUG : movies/lancamentos2020/: Lookup: name="46798.mp4"
2022/01/07 15:54:42 DEBUG : : Statfs: 
2022/01/07 15:54:42 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:42 DEBUG : : Statfs: 
2022/01/07 15:54:42 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/: >Lookup: node=movies/lancamentos2020/46798.mp4, err=<nil>
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/46798.mp4: Attr: 
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/46798.mp4: >Attr: a=valid=1s ino=0 size=890896717 mode=-rw-r--r--, err=<nil>
2022/01/07 15:54:42 DEBUG : /: Lookup: name="movies"
2022/01/07 15:54:42 DEBUG : /: >Lookup: node=movies/, err=<nil>
2022/01/07 15:54:42 DEBUG : movies/: Attr: 
2022/01/07 15:54:42 DEBUG : movies/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=<nil>
2022/01/07 15:54:42 DEBUG : movies/: Lookup: name="lancamentos2020"
2022/01/07 15:54:42 DEBUG : movies/: >Lookup: node=movies/lancamentos2020/, err=<nil>
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/: Attr: 
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=<nil>
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/46798.mp4: Open: flags=OpenReadOnly
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/46798.mp4: Open: flags=O_RDONLY
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/46798.mp4: >Open: fd=movies/lancamentos2020/46798.mp4 (r), err=<nil>
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/46798.mp4: >Open: fh=&{movies/lancamentos2020/46798.mp4 (r)}, err=<nil>
2022/01/07 15:54:42 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=0
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.openRange at 0 length 134217728
2022/01/07 15:54:42 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 0 length 4096 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:43 DEBUG : : Statfs: 
2022/01/07 15:54:43 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:43 DEBUG : : Statfs: 
2022/01/07 15:54:43 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:43 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 4096 length 8192 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:43 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 12288 length 16384 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:43 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 28672 length 32768 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:43 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 61440 length 65536 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:43 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 126976 length 131072 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:44 DEBUG : : Statfs: 
2022/01/07 15:54:44 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:44 DEBUG : : Statfs: 
2022/01/07 15:54:44 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 258048 length 262144 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:44 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 520192 length 524288 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 1044480 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 2093056 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 3141632 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:44 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Flush: 
2022/01/07 15:54:44 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Flush: err=<nil>
2022/01/07 15:54:44 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Release: 
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.Release closing
2022/01/07 15:54:44 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Release: err=<nil>
2022/01/07 15:54:44 DEBUG : /: Lookup: name="movies"
2022/01/07 15:54:44 DEBUG : /: >Lookup: node=movies/, err=<nil>
2022/01/07 15:54:44 DEBUG : movies/: Attr: 
2022/01/07 15:54:44 DEBUG : movies/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=<nil>
2022/01/07 15:54:44 DEBUG : movies/: Lookup: name="lancamentos2020"
2022/01/07 15:54:44 DEBUG : movies/: >Lookup: node=movies/lancamentos2020/, err=<nil>
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/: Attr: 
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=<nil>
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/: Lookup: name="46798.mp4"
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/: >Lookup: node=movies/lancamentos2020/46798.mp4, err=<nil>
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: Attr: 
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: >Attr: a=valid=1s ino=0 size=890896717 mode=-rw-r--r--, err=<nil>
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: Open: flags=OpenReadOnly
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: Open: flags=O_RDONLY
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: >Open: fd=movies/lancamentos2020/46798.mp4 (r), err=<nil>
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: >Open: fh=&{movies/lancamentos2020/46798.mp4 (r)}, err=<nil>
2022/01/07 15:54:44 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=0
2022/01/07 15:54:44 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.openRange at 0 length 134217728
2022/01/07 15:54:44 DEBUG : ftps://ftp.box.com:990: Connecting to FTP server
2022/01/07 15:54:45 DEBUG : : Statfs: 
2022/01/07 15:54:45 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:45 DEBUG : : Statfs: 
2022/01/07 15:54:45 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:46 DEBUG : : Statfs: 
2022/01/07 15:54:46 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:46 DEBUG : : Statfs: 
2022/01/07 15:54:46 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:46 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 0 length 4096 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:47 DEBUG : : Statfs: 
2022/01/07 15:54:47 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:47 DEBUG : : Statfs: 
2022/01/07 15:54:47 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:47 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 4096 length 8192 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:47 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 12288 length 16384 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:47 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 28672 length 32768 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:47 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 61440 length 65536 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:47 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 126976 length 131072 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:47 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 258048 length 262144 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:47 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:47 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 520192 length 524288 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:47 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 1044480 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:47 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 2093056 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : : Statfs: 
2022/01/07 15:54:48 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:48 DEBUG : : Statfs: 
2022/01/07 15:54:48 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 3141632 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 4190208 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 5238784 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 6287360 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=131072
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=262144
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 7335936 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 8384512 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 9433088 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 10481664 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 11530240 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 12578816 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 13627392 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=393216
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=524288
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 14675968 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 15724544 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=655360
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=786432
2022/01/07 15:54:48 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:49 DEBUG : : Statfs: 
2022/01/07 15:54:49 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:49 DEBUG : : Statfs: 
2022/01/07 15:54:49 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:49 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=917504
2022/01/07 15:54:49 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:49 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 16773120 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:49 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=1048576
2022/01/07 15:54:49 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:49 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=1179648
2022/01/07 15:54:49 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:50 DEBUG : : Statfs: 
2022/01/07 15:54:50 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:50 DEBUG : : Statfs: 
2022/01/07 15:54:50 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:50 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=1310720
2022/01/07 15:54:50 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:50 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=1441792
2022/01/07 15:54:50 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:50 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=1572864
2022/01/07 15:54:50 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=1703936
2022/01/07 15:54:50 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:50 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:51 DEBUG : : Statfs: 
2022/01/07 15:54:51 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:51 DEBUG : : Statfs: 
2022/01/07 15:54:51 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:51 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=1835008
2022/01/07 15:54:51 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:51 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=1966080
2022/01/07 15:54:51 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:51 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=2097152
2022/01/07 15:54:51 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 17821696 length 1048576 chunkOffset 0 chunkSize 134217728
2022/01/07 15:54:51 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:51 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=2228224
2022/01/07 15:54:51 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:52 DEBUG : : Statfs: 
2022/01/07 15:54:52 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:52 DEBUG : : Statfs: 
2022/01/07 15:54:52 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=2490368
2022/01/07 15:54:52 DEBUG : movies/lancamentos2020/46798.mp4: waiting for in-sequence read to 2490368 for 20ms
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=2359296
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=2621440
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=2752512
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=131072, offset=2883584
2022/01/07 15:54:52 DEBUG : movies/lancamentos2020/46798.mp4: waiting for in-sequence read to 2883584 for 20ms
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Read: read=131072, err=<nil>
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Flush: 
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Flush: err=<nil>
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Release: 
2022/01/07 15:54:52 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.Release closing
2022/01/07 15:54:52 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: >Release: err=<nil>
2022/01/07 15:54:53 DEBUG : : Statfs: 
2022/01/07 15:54:53 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:53 DEBUG : : Statfs: 
2022/01/07 15:54:53 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:53 DEBUG : /: Lookup: name="movies"
2022/01/07 15:54:53 DEBUG : /: >Lookup: node=movies/, err=<nil>
2022/01/07 15:54:53 DEBUG : movies/: Attr: 
2022/01/07 15:54:53 DEBUG : movies/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=<nil>
2022/01/07 15:54:53 DEBUG : movies/: Lookup: name="lancamentos2020"
2022/01/07 15:54:53 DEBUG : movies/: >Lookup: node=movies/lancamentos2020/, err=<nil>
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/: Attr: 
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxr-xr-x, err=<nil>
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/: Lookup: name="46798.mp4"
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/: >Lookup: node=movies/lancamentos2020/46798.mp4, err=<nil>
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/46798.mp4: Attr: 
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/46798.mp4: >Attr: a=valid=1s ino=0 size=890896717 mode=-rw-r--r--, err=<nil>
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/46798.mp4: Open: flags=OpenReadOnly
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/46798.mp4: Open: flags=O_RDONLY
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/46798.mp4: >Open: fd=movies/lancamentos2020/46798.mp4 (r), err=<nil>
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/46798.mp4: >Open: fh=&{movies/lancamentos2020/46798.mp4 (r)}, err=<nil>
2022/01/07 15:54:53 DEBUG : &{movies/lancamentos2020/46798.mp4 (r)}: Read: len=69632, offset=890830848
2022/01/07 15:54:53 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.openRange at 0 length 134217728
2022/01/07 15:54:53 DEBUG : ftps://ftp.box.com:990: Connecting to FTP server
2022/01/07 15:54:54 DEBUG : : Statfs: 
2022/01/07 15:54:54 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:54 DEBUG : : Statfs: 
2022/01/07 15:54:54 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:54 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.seek from 0 to 890830848 (fs.RangeSeeker)
2022/01/07 15:54:54 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.RangeSeek from 0 to 890830848 length -1
2022/01/07 15:54:54 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at -1 length 4096 chunkOffset 890830848 chunkSize 134217728
2022/01/07 15:54:54 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.openRange at 890830848 length 134217728
2022/01/07 15:54:54 DEBUG : ftps://ftp.box.com:990: Connecting to FTP server
2022/01/07 15:54:55 DEBUG : : Statfs: 
2022/01/07 15:54:55 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:55 DEBUG : : Statfs: 
2022/01/07 15:54:55 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:56 DEBUG : : Statfs: 
2022/01/07 15:54:56 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:56 DEBUG : : Statfs: 
2022/01/07 15:54:56 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:56 ERROR : movies/lancamentos2020/46798.mp4: ReadFileHandle.Read error: low level retry 1/10: 425 Can't open data connection.
2022/01/07 15:54:56 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.seek from 890830848 to 890830848
2022/01/07 15:54:56 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.RangeSeek from -1 to 890830848 length -1
2022/01/07 15:54:56 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.openRange at 890830848 length 134217728
2022/01/07 15:54:56 DEBUG : ftps://ftp.box.com:990: Connection failed, closing: use of closed network connection
2022/01/07 15:54:56 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.Read seek failed: open: use of closed network connection
2022/01/07 15:54:56 ERROR : movies/lancamentos2020/46798.mp4: ReadFileHandle.Read error: low level retry 2/10: open: use of closed network connection
2022/01/07 15:54:56 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.seek from 890830848 to 890830848
2022/01/07 15:54:56 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.Read seek close old failed: file already closed
2022/01/07 15:54:56 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.RangeSeek from -1 to 890830848 length -1
2022/01/07 15:54:56 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.openRange at 890830848 length 134217728
2022/01/07 15:54:56 DEBUG : ftps://ftp.box.com:990: Connecting to FTP server
2022/01/07 15:54:57 DEBUG : : Statfs: 
2022/01/07 15:54:57 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:57 DEBUG : : Statfs: 
2022/01/07 15:54:57 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:58 DEBUG : : Statfs: 
2022/01/07 15:54:58 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:58 DEBUG : : Statfs: 
2022/01/07 15:54:58 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:58 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 890830848 length 4096 chunkOffset 890830848 chunkSize 134217728
2022/01/07 15:54:59 DEBUG : : Statfs: 
2022/01/07 15:54:59 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:59 DEBUG : : Statfs: 
2022/01/07 15:54:59 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:54:59 ERROR : movies/lancamentos2020/46798.mp4: ReadFileHandle.Read error: low level retry 3/10: EOF
2022/01/07 15:54:59 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.seek from 890830848 to 890830848
2022/01/07 15:54:59 DEBUG : movies/lancamentos2020/46798.mp4: ReadFileHandle.Read seek close old failed: 551 Box: Partial-file downloads are not supported.
2022/01/07 15:54:59 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.RangeSeek from -1 to 890830848 length -1
2022/01/07 15:54:59 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.openRange at 890830848 length 134217728
2022/01/07 15:54:59 DEBUG : ftps://ftp.box.com:990: Connecting to FTP server
2022/01/07 15:55:00 DEBUG : : Statfs: 
2022/01/07 15:55:00 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:55:00 DEBUG : : Statfs: 
2022/01/07 15:55:00 DEBUG : : >Statfs: stat={Blocks:274877906944 Bfree:274877906944 Bavail:274877906944 Files:1000000000 Ffree:1000000000 Bsize:4096 Namelen:255 Frsize:4096}, err=<nil>
2022/01/07 15:55:00 DEBUG : movies/lancamentos2020/46798.mp4: ChunkedReader.Read at 890830848 length 4096 chunkOffset 890830848 chunkSize 134217728
2

hi,
try adding --vfs-cache-mode-full

and what are you using the rclone mount for, a web server?

3

Why are you using a FTP remote when there is a box remote?

Box (rclone.org)

4

@felipesantos989
I think you are right and partial reading being unsupported by the box.com ftp server is the root cause here. Support for reading block-by-block is currently a hard requirement of rclone mount. We have captured a request to support such limited clouds in the following ticket (which I don't think will be fixed in the near future due to scarce developer resources of the project):
New backend feature flag for backends which can't Range/Seek · Issue #4733 · rclone/rclone · GitHub

In the mean time I suggest using official box.com backend Box which is free from this limitation.

Also... could you do me a favor and spend an hour to investigate the issue? Please run the below command in a dedicated console. The command will not exit, it will sit silently in the console like a bird on nested eggs, serve the mount and record the debug log.

rclone mount boxftp:/ /var/www/html/storage777 --allow-other --dump bodies --log-file /tmp/debug-box-ftp.log

Then repeat your mount usage pattern from second console and let it fail with the movie. Then stop the silent rclone with ^C (the mount in the second console will cease), compress the log and attach below.

Thank you in advance.
Ivan

5

What do you mean box remote? do you mean their API? or anything else?
if it's their API, they have a limit of requests on their API per month, and i need more than the limit.
on FTP doesn't have limit, so that's the reason i need to do this with FTP and not with API.

6

I mean the link I shared that you didn't click on to answer your own question.

I lack the ability to read your mind so unless you share it, I can only share advice/support. Almost every provider have some limits on their API so they don't get flooded. What limit are you hitting as they seem pretty nice from other providers:

Rate Limits - Box Developer Documentation

7

And from Box Support:

image
image1012×410 57.4 KB

8

If helpful @ivandeex as you love FTP :slight_smile:

Using Box with FTP or FTPS – Box Support

Not sure if that gives you more details as I've purged any FTP knowledge from my brain years ago.

9

lol, sorry, i didn't see this link.

but talking about limits, that's the limit that i'm talking about, i use the business plan, they allow you to make 50.000 requests per month on their API, so that's why i'll not use their API.

Capture
Capture495×522 16.3 KB

on this image (below), as you can see, i've received more than 500k requests only in 24h.
so i would hit the monthly limit in one day, so that's why i'm trying to make it work with FTP, their ftp doesn't have any limits, at least that's what i think.

Capture
Capture710×546 36.7 KB

10

Might want to check out dropbox as from my cursory glance, the prices seem the same and there are not any API use limits other than normal rate limiting. They turned off any API limits per month.

image

11

Wow thanks a lot, i was already thinking of using dropbox if i didn't solve this issue with box, but i hadn't searched yet about dropbox limits, thanks, i'm going to try it.

12

You can trial them as well as that's what I did.

I did a trial, asked for the space I needed, tested for a bit and validated things work.

Support is responsive as well so I asked all my questions prior to making a longer term commitment as I am on a yearly plan now.

1 Like
13

if i were doing a large migration,
for a bunch of reasons, i would use rclone copy, not rclone mount.

1 Like
14

This topic was automatically closed 30 days after the last reply. New replies are no longer allowed.