Taking too long to Initialize nextcloud instance and then giving error

Help and Support
1

What is the problem you are having with rclone?

I have mounted encrypted google drive(named: gdrive) on /mnt/nextcloud.
Docker command for nextcloud is :-

docker run -d \
	-v /mnt/nextcloud:/var/www/html \
	--expose 80 \
	-e MYSQL_PASSWORD=**HIDDEN** \
	-e MYSQL_DATABASE=nextcloud \
	-e MYSQL_USER=nextcloud \
	-e MYSQL_HOST=db \
	nextcloud

Problems:-

  1. It takes whoping 1 hour 40 minutes to upload the file, my internet speed is 50 Mbits upload & download
  2. While uploading Nextcloud container is stuck at Initializing nextcloud 23.0.6.1 ... . I thought the data will be written to cache immediately and nextcloud will use data from cache while it is synced in background.
  3. After the upload is completed the nextcloud container gives the following error:-
Retrying install...
Console has to be executed with the user that owns the file config/config.php
Current user id: 33
Owner id of config.php: 0
Try adding 'sudo -u #0' to the beginning of the command (without the single quotes)
If running with 'docker exec' try adding the option '-u 0' to the docker command (without the single quotes)
Installing of nextcloud failed!

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

rclone v1.58.1

  • os/version: ubuntu 22.04 (64 bit)
  • os/kernel: 5.15.0-30-generic (x86_64)
  • os/type: linux
  • os/arch: amd64
  • go/version: go1.17.9
  • go/linking: static
  • go/tags: none

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

Google Drive

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

sudo /usr/local/bin/rclone mount \
--config /root/.config/rclone/rclone.conf \
--cache-dir /root/.cache/rclone \
gdrive_crypt:nextcloud /mnt/nextcloud \
--checksum \
--transfers 100 \
--allow-other \
--vfs-cache-mode full \
--dir-cache-time 96h \
--log-file /var/log/rclone/rclone.log \
--log-level DEBUG \
--poll-interval 10s \
--vfs-cache-max-age 96h \
--dir-cache-time 1h \
--vfs-cache-max-size 6G \
--vfs-write-back 10s \
--umask 002 \
--tpslimit 110 \
--tpslimit-burst 110 \
--daemon

The rclone config contents with secrets removed.

[gdrive]
type = drive
client_id = **HIDDEN**
client_secret = **HIDDEN**
scope = drive
token = {"access_token":**HIDDEN**,"token_type":"Bearer","refresh_token":**HIDDEN**,"expiry":"2022-06-27T18:10:59.376315+05:30"}
team_drive = 

[gdrive_crypt]
type = crypt
remote = gdrive:/encrypted
password = **HIDDEN**
password2 = **HIDDEN**

A log from the command with the -vv flag

The log file is very large so I have used : head -n 500 /var/log/rclone/rclone.log
Total No. of files are around 25000 and 500MB.

Note: Log file is intentionally kept small to maintain the body size of forum but Logs at end keep repeating for different files.

2022/06/28 00:04:41 INFO  : Starting transaction limiter: max 110 transactions/s with burst 110
2022/06/28 00:04:41 DEBUG : rclone: Version "v1.58.1" starting with parameters ["/usr/local/bin/rclone" "mount" "--config" "/root/.config/rclone/rclone.conf" "--cache-dir" "/root/.cache/rclone" "cipheres77_crypt:nextcloud" "/mnt/nextcloud" "--checksum" "--transfers" "100" "--allow-other" "--vfs-cache-mode" "full" "--dir-cache-time" "96h" "--log-file" "/var/log/rclone/rclone.log" "--log-level" "DEBUG" "--poll-interval" "10s" "--vfs-cache-max-age" "96h" "--dir-cache-time" "1h" "--vfs-cache-max-size" "6G" "--vfs-write-back" "10s" "--umask" "002" "--tpslimit" "110" "--tpslimit-burst" "110" "--daemon"]
2022/06/28 00:04:41 DEBUG : Creating backend with remote "gdrive_crypt:nextcloud"
2022/06/28 00:04:41 DEBUG : Using config file from "/root/.config/rclone/rclone.conf"
2022/06/28 00:04:41 DEBUG : Creating backend with remote "gdrive:/encrypted/tjs3ahanhbsrrk9qfctjdun414"
2022/06/28 00:04:41 DEBUG : gdrive: Loaded invalid token from config file - ignoring
2022/06/28 00:04:42 DEBUG : Saving config "token" in section "gdrive" of the config file
2022/06/28 00:04:42 DEBUG : gdrive: Saved new token in config file
2022/06/28 00:04:42 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': 'root_folder_id = 0AFQHByrfyFf3Uk9PVA' - save this in the config to speed up startup
2022/06/28 00:04:43 DEBUG : fs cache: renaming cache item "gdrive:/encrypted/tjs3ahanhbsrrk9qfctjdun414" to be canonical "gdrive:encrypted/tjs3ahanhbsrrk9qfctjdun414"
2022/06/28 00:04:43 DEBUG : fs cache: switching user supplied name "gdrive:/encrypted/tjs3ahanhbsrrk9qfctjdun414" for canonical name "gdrive:encrypted/tjs3ahanhbsrrk9qfctjdun414"
2022/06/28 00:04:43 INFO  : Starting transaction limiter: max 110 transactions/s with burst 110
2022/06/28 00:04:43 DEBUG : rclone: Version "v1.58.1" starting with parameters ["/usr/local/bin/rclone" "mount" "--config" "/root/.config/rclone/rclone.conf" "--cache-dir" "/root/.cache/rclone" "gdrive_crypt:nextcloud" "/mnt/nextcloud" "--checksum" "--transfers" "100" "--allow-other" "--vfs-cache-mode" "full" "--dir-cache-time" "96h" "--log-file" "/var/log/rclone/rclone.log" "--log-level" "DEBUG" "--poll-interval" "10s" "--vfs-cache-max-age" "96h" "--dir-cache-time" "1h" "--vfs-cache-max-size" "6G" "--vfs-write-back" "10s" "--umask" "002" "--tpslimit" "110" "--tpslimit-burst" "110" "--daemon"]
2022/06/28 00:04:43 DEBUG : Creating backend with remote "gdrive_crypt:nextcloud"
2022/06/28 00:04:43 DEBUG : Using config file from "/root/.config/rclone/rclone.conf"
2022/06/28 00:04:44 DEBUG : Creating backend with remote "gdrive:/encrypted/tjs3ahanhbsrrk9qfctjdun414"
2022/06/28 00:04:44 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': 'root_folder_id = 0AFQHByrfyFf3Uk9PVA' - save this in the config to speed up startup
2022/06/28 00:04:45 DEBUG : fs cache: renaming cache item "gdrive:/encrypted/tjs3ahanhbsrrk9qfctjdun414" to be canonical "gdrive:encrypted/tjs3ahanhbsrrk9qfctjdun414"
2022/06/28 00:04:45 DEBUG : fs cache: switching user supplied name "gdrive:/encrypted/tjs3ahanhbsrrk9qfctjdun414" for canonical name "gdrive:encrypted/tjs3ahanhbsrrk9qfctjdun414"
2022/06/28 00:04:45 DEBUG : vfs cache: root is "/root/.cache/rclone"
2022/06/28 00:04:45 DEBUG : vfs cache: data root is "/root/.cache/rclone/vfs/gdrive_crypt/nextcloud"
2022/06/28 00:04:45 DEBUG : vfs cache: metadata root is "/root/.cache/rclone/vfsMeta/gdrive_crypt/nextcloud"
2022/06/28 00:04:45 DEBUG : Creating backend with remote "/root/.cache/rclone/vfs/gdrive_crypt/nextcloud"
2022/06/28 00:04:45 DEBUG : Creating backend with remote "/root/.cache/rclone/vfsMeta/gdrive_crypt/nextcloud"
2022/06/28 00:04:45 DEBUG : Encrypted drive 'gdrive_crypt:nextcloud': Mounting on "/mnt/nextcloud"
2022/06/28 00:04:45 INFO  : vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
2022/06/28 00:04:45 DEBUG : : Root: 
2022/06/28 00:04:45 DEBUG : : >Root: node=/, err=<nil>
2022/06/28 00:04:45 DEBUG : rclone: Version "v1.58.1" finishing with parameters ["/usr/local/bin/rclone" "mount" "--config" "/root/.config/rclone/rclone.conf" "--cache-dir" "/root/.cache/rclone" "gdrive_crypt:nextcloud" "/mnt/nextcloud" "--checksum" "--transfers" "100" "--allow-other" "--vfs-cache-mode" "full" "--dir-cache-time" "96h" "--log-file" "/var/log/rclone/rclone.log" "--log-level" "DEBUG" "--poll-interval" "10s" "--vfs-cache-max-age" "96h" "--dir-cache-time" "1h" "--vfs-cache-max-size" "6G" "--vfs-write-back" "10s" "--umask" "002" "--tpslimit" "110" "--tpslimit-burst" "110" "--daemon"]
2022/06/28 00:04:55 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:05:05 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:05:15 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:05:25 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:05:35 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:05:45 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:05:45 INFO  : vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
2022/06/28 00:05:55 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:06:05 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:06:15 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:06:25 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:06:35 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:06:45 INFO  : vfs cache: cleaned: objects 0 (was 0) in use 0, to upload 0, uploading 0, total size 0 (was 0)
2022/06/28 00:06:45 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:06:55 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:07:05 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:07:15 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:07:25 DEBUG : /: Attr: 
2022/06/28 00:07:25 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=<nil>
2022/06/28 00:07:25 DEBUG : Google drive root 'encrypted/tjs3ahanhbsrrk9qfctjdun414': Checking for changes on remote
2022/06/28 00:07:26 DEBUG : /: Lookup: name="version.php"
2022/06/28 00:07:26 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:26 DEBUG : /: Lookup: name="nextcloud-init-sync.lock"
2022/06/28 00:07:26 DEBUG : /: >Lookup: node=nextcloud-init-sync.lock, err=<nil>
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: Attr: 
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: >Attr: a=valid=1s ino=0 size=0 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: Open: flags=OpenWriteOnly+OpenNonblock
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: Open: flags=O_WRONLY|0x800
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: newRWFileHandle: 
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: >newRWFileHandle: err=<nil>
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: >Open: fd=nextcloud-init-sync.lock (rw), err=<nil>
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: >Open: fh=&{nextcloud-init-sync.lock (rw)}, err=<nil>
2022/06/28 00:07:26 DEBUG : &{nextcloud-init-sync.lock (rw)}: Flush: 
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock(0xc000282940): RWFileHandle.Flush
2022/06/28 00:07:26 DEBUG : &{nextcloud-init-sync.lock (rw)}: >Flush: err=<nil>
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: Setattr: a=Setattr [ID=0x10 Node=0x2 Uid=0 Gid=0 Pid=19933] atime=2022-06-28 00:07:26.831124736 +0530 IST atime=now mtime=2022-06-28 00:07:26.831124736 +0530 IST mtime=now handle=INVALID-0x0
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: >Setattr: err=<nil>
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: Attr: 
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock: >Attr: a=valid=1s ino=0 size=0 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:26 DEBUG : &{nextcloud-init-sync.lock (rw)}: Flush: 
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock(0xc000282940): RWFileHandle.Flush
2022/06/28 00:07:26 DEBUG : &{nextcloud-init-sync.lock (rw)}: >Flush: err=<nil>
2022/06/28 00:07:26 DEBUG : &{nextcloud-init-sync.lock (rw)}: Release: 
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock(0xc000282940): RWFileHandle.Release
2022/06/28 00:07:26 DEBUG : nextcloud-init-sync.lock(0xc000282940): close: 
2022/06/28 00:07:26 DEBUG : /: Attr: 
2022/06/28 00:07:26 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=<nil>
2022/06/28 00:07:26 DEBUG : /: Setattr: stat=Setattr [ID=0x1c Node=0x1 Uid=0 Gid=0 Pid=19935] uid=33 gid=0 handle=INVALID-0x0
2022/06/28 00:07:26 DEBUG : /: >Setattr: err=<nil>
2022/06/28 00:07:26 DEBUG : /: Attr: 
2022/06/28 00:07:26 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=<nil>
2022/06/28 00:07:26 DEBUG : /: ReadDirAll: 
2022/06/28 00:07:28 DEBUG : nextcloud-init-sync.lock: Applied pending mod time 2022-06-28 00:07:26.831124736 +0530 IST OK
2022/06/28 00:07:28 DEBUG : nextcloud-init-sync.lock(0xc000282940): >close: err=<nil>
2022/06/28 00:07:28 DEBUG : &{nextcloud-init-sync.lock (rw)}: >Release: err=<nil>
2022/06/28 00:07:28 DEBUG : /: >ReadDirAll: item=17, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name=".htaccess"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=.htaccess, err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess: Attr: 
2022/06/28 00:07:28 DEBUG : .htaccess: >Attr: a=valid=1s ino=0 size=3350 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name=".user.ini"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=.user.ini, err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini: Attr: 
2022/06/28 00:07:28 DEBUG : .user.ini: >Attr: a=valid=1s ino=0 size=101 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="3rdparty"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=3rdparty/, err=<nil>
2022/06/28 00:07:28 DEBUG : 3rdparty/: Attr: 
2022/06/28 00:07:28 DEBUG : 3rdparty/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="AUTHORS"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=AUTHORS, err=<nil>
2022/06/28 00:07:28 DEBUG : AUTHORS: Attr: 
2022/06/28 00:07:28 DEBUG : AUTHORS: >Attr: a=valid=1s ino=0 size=19327 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="COPYING"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=COPYING, err=<nil>
2022/06/28 00:07:28 DEBUG : COPYING: Attr: 
2022/06/28 00:07:28 DEBUG : COPYING: >Attr: a=valid=1s ino=0 size=34520 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="console.php"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=console.php, err=<nil>
2022/06/28 00:07:28 DEBUG : console.php: Attr: 
2022/06/28 00:07:28 DEBUG : console.php: >Attr: a=valid=1s ino=0 size=4095 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="cron.php"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=cron.php, err=<nil>
2022/06/28 00:07:28 DEBUG : cron.php: Attr: 
2022/06/28 00:07:28 DEBUG : cron.php: >Attr: a=valid=1s ino=0 size=6260 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="index.html"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=index.html, err=<nil>
2022/06/28 00:07:28 DEBUG : index.html: Attr: 
2022/06/28 00:07:28 DEBUG : index.html: >Attr: a=valid=1s ino=0 size=156 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="index.php"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=index.php, err=<nil>
2022/06/28 00:07:28 DEBUG : index.php: Attr: 
2022/06/28 00:07:28 DEBUG : index.php: >Attr: a=valid=1s ino=0 size=3456 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="nextcloud-init-sync.lock"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=nextcloud-init-sync.lock, err=<nil>
2022/06/28 00:07:28 DEBUG : nextcloud-init-sync.lock: Attr: 
2022/06/28 00:07:28 DEBUG : nextcloud-init-sync.lock: >Attr: a=valid=1s ino=0 size=0 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="occ"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=occ, err=<nil>
2022/06/28 00:07:28 DEBUG : occ: Attr: 
2022/06/28 00:07:28 DEBUG : occ: >Attr: a=valid=1s ino=0 size=283 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="public.php"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=public.php, err=<nil>
2022/06/28 00:07:28 DEBUG : public.php: Attr: 
2022/06/28 00:07:28 DEBUG : public.php: >Attr: a=valid=1s ino=0 size=3139 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="remote.php"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=remote.php, err=<nil>
2022/06/28 00:07:28 DEBUG : remote.php: Attr: 
2022/06/28 00:07:28 DEBUG : remote.php: >Attr: a=valid=1s ino=0 size=5340 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="robots.txt"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=robots.txt, err=<nil>
2022/06/28 00:07:28 DEBUG : robots.txt: Attr: 
2022/06/28 00:07:28 DEBUG : robots.txt: >Attr: a=valid=1s ino=0 size=26 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="status.php"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=status.php, err=<nil>
2022/06/28 00:07:28 DEBUG : status.php: Attr: 
2022/06/28 00:07:28 DEBUG : status.php: >Attr: a=valid=1s ino=0 size=2452 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Attr: 
2022/06/28 00:07:28 DEBUG : /: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name="apps"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : /: Lookup: name="core"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : /: Lookup: name="lib"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : /: Lookup: name="ocm-provider"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : /: Lookup: name="ocs-provider"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : /: Lookup: name="ocs"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : /: Lookup: name="resources"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : 3rdparty/: Setattr: stat=Setattr [ID=0x54 Node=0x5 Uid=0 Gid=0 Pid=19935] uid=33 gid=0 handle=INVALID-0x0
2022/06/28 00:07:28 DEBUG : 3rdparty/: >Setattr: err=<nil>
2022/06/28 00:07:28 DEBUG : 3rdparty/: Attr: 
2022/06/28 00:07:28 DEBUG : 3rdparty/: >Attr: attr=valid=1s ino=0 size=0 mode=drwxrwxr-x, err=<nil>
2022/06/28 00:07:28 DEBUG : 3rdparty/: ReadDirAll: 
2022/06/28 00:07:28 DEBUG : .htaccess: Open: flags=OpenReadOnly
2022/06/28 00:07:28 DEBUG : .htaccess: Open: flags=O_RDONLY
2022/06/28 00:07:28 DEBUG : .htaccess: newRWFileHandle: 
2022/06/28 00:07:28 DEBUG : .htaccess: >newRWFileHandle: err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess: >Open: fd=.htaccess (rw), err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess: >Open: fh=&{.htaccess (rw)}, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name=".htaccess.ZuNjvF"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : /: Create: name=".htaccess.ZuNjvF"
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: Open: flags=O_RDWR|O_CREATE|O_EXCL
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: newRWFileHandle: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF(0xc001968dc0): openPending: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: vfs cache: truncate to size=0
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vAddFile: ".htaccess.ZuNjvF"
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF(0xc001968dc0): >openPending: err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: >newRWFileHandle: err=<nil>
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vAddFile: ".htaccess.ZuNjvF"
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: >Open: fd=.htaccess.ZuNjvF (rw), err=<nil>
2022/06/28 00:07:28 DEBUG : /: >Create: node=.htaccess.ZuNjvF, handle=&{.htaccess.ZuNjvF (rw)}, err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: Attr: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: >Attr: a=valid=1s ino=0 size=0 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: Setattr: a=Setattr [ID=0x62 Node=0x11 Uid=0 Gid=0 Pid=19936] mode=-rw------- handle=INVALID-0x0
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: >Setattr: err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: Attr: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: >Attr: a=valid=1s ino=0 size=0 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : &{.htaccess.ZuNjvF (rw)}: Write: len=3350, offset=0
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF(0xc001968dc0): _writeAt: size=3350, off=0
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF(0xc001968dc0): >_writeAt: n=3350, err=<nil>
2022/06/28 00:07:28 DEBUG : &{.htaccess.ZuNjvF (rw)}: >Write: written=3350, err=<nil>
2022/06/28 00:07:28 DEBUG : &{.htaccess (rw)}: Flush: 
2022/06/28 00:07:28 DEBUG : .htaccess(0xc001968c40): RWFileHandle.Flush
2022/06/28 00:07:28 DEBUG : &{.htaccess (rw)}: >Flush: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.htaccess (rw)}: Release: 
2022/06/28 00:07:28 DEBUG : .htaccess(0xc001968c40): RWFileHandle.Release
2022/06/28 00:07:28 DEBUG : .htaccess(0xc001968c40): close: 
2022/06/28 00:07:28 DEBUG : .htaccess(0xc001968c40): >close: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.htaccess (rw)}: >Release: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.htaccess.ZuNjvF (rw)}: Flush: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF(0xc001968dc0): RWFileHandle.Flush
2022/06/28 00:07:28 DEBUG : &{.htaccess.ZuNjvF (rw)}: >Flush: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.htaccess.ZuNjvF (rw)}: Release: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF(0xc001968dc0): RWFileHandle.Release
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF(0xc001968dc0): close: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: vfs cache: setting modification time to 2022-06-28 00:07:28.041897004 +0530 IST m=+164.203008694
2022/06/28 00:07:28 INFO  : .htaccess.ZuNjvF: vfs cache: queuing for upload in 10s
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF(0xc001968dc0): >close: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.htaccess.ZuNjvF (rw)}: >Release: err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: Attr: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: >Attr: a=valid=1s ino=0 size=3350 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: Attr: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: >Attr: a=valid=1s ino=0 size=3350 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: Setattr: a=Setattr [ID=0x74 Node=0x11 Uid=0 Gid=0 Pid=19936] uid=33 gid=0 handle=INVALID-0x0
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: >Setattr: err=<nil>
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: Attr: 
2022/06/28 00:07:28 DEBUG : .htaccess.ZuNjvF: >Attr: a=valid=1s ino=0 size=3350 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Rename: oldName=".htaccess.ZuNjvF", newName=".htaccess", newDir=/
2022/06/28 00:07:28 INFO  : .htaccess.ZuNjvF: vfs cache: renamed in cache to ".htaccess"
2022/06/28 00:07:28 DEBUG : .htaccess: Updating file with <nil> 0xc0019f3b00
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vDel: ".htaccess.ZuNjvF"
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vAddFile: ".htaccess"
2022/06/28 00:07:28 DEBUG : /: >Rename: err=<nil>
2022/06/28 00:07:28 DEBUG : /: Invalidating ".htaccess"
2022/06/28 00:07:28 DEBUG : .user.ini: Open: flags=OpenReadOnly
2022/06/28 00:07:28 DEBUG : .user.ini: Open: flags=O_RDONLY
2022/06/28 00:07:28 DEBUG : .user.ini: newRWFileHandle: 
2022/06/28 00:07:28 DEBUG : .user.ini: >newRWFileHandle: err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini: >Open: fd=.user.ini (rw), err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini: >Open: fh=&{.user.ini (rw)}, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name=".user.ini.cT0lwJ"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : /: Create: name=".user.ini.cT0lwJ"
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: Open: flags=O_RDWR|O_CREATE|O_EXCL
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: newRWFileHandle: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ(0xc001a6bb00): openPending: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: vfs cache: truncate to size=0
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vAddFile: ".user.ini.cT0lwJ"
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ(0xc001a6bb00): >openPending: err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: >newRWFileHandle: err=<nil>
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vAddFile: ".user.ini.cT0lwJ"
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: >Open: fd=.user.ini.cT0lwJ (rw), err=<nil>
2022/06/28 00:07:28 DEBUG : /: >Create: node=.user.ini.cT0lwJ, handle=&{.user.ini.cT0lwJ (rw)}, err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: Attr: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: >Attr: a=valid=1s ino=0 size=0 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: Setattr: a=Setattr [ID=0x82 Node=0x11 Uid=0 Gid=0 Pid=19936] mode=-rw------- handle=INVALID-0x0
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: >Setattr: err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: Attr: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: >Attr: a=valid=1s ino=0 size=0 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : &{.user.ini.cT0lwJ (rw)}: Write: len=101, offset=0
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ(0xc001a6bb00): _writeAt: size=101, off=0
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ(0xc001a6bb00): >_writeAt: n=101, err=<nil>
2022/06/28 00:07:28 DEBUG : &{.user.ini.cT0lwJ (rw)}: >Write: written=101, err=<nil>
2022/06/28 00:07:28 DEBUG : &{.user.ini (rw)}: Flush: 
2022/06/28 00:07:28 DEBUG : .user.ini(0xc001a6b980): RWFileHandle.Flush
2022/06/28 00:07:28 DEBUG : &{.user.ini (rw)}: >Flush: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.user.ini (rw)}: Release: 
2022/06/28 00:07:28 DEBUG : .user.ini(0xc001a6b980): RWFileHandle.Release
2022/06/28 00:07:28 DEBUG : .user.ini(0xc001a6b980): close: 
2022/06/28 00:07:28 DEBUG : .user.ini(0xc001a6b980): >close: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.user.ini (rw)}: >Release: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.user.ini.cT0lwJ (rw)}: Flush: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ(0xc001a6bb00): RWFileHandle.Flush
2022/06/28 00:07:28 DEBUG : &{.user.ini.cT0lwJ (rw)}: >Flush: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.user.ini.cT0lwJ (rw)}: Release: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ(0xc001a6bb00): RWFileHandle.Release
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ(0xc001a6bb00): close: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: vfs cache: setting modification time to 2022-06-28 00:07:28.044253313 +0530 IST m=+164.205365003
2022/06/28 00:07:28 INFO  : .user.ini.cT0lwJ: vfs cache: queuing for upload in 10s
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ(0xc001a6bb00): >close: err=<nil>
2022/06/28 00:07:28 DEBUG : &{.user.ini.cT0lwJ (rw)}: >Release: err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: Attr: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: >Attr: a=valid=1s ino=0 size=101 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: Attr: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: >Attr: a=valid=1s ino=0 size=101 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: Setattr: a=Setattr [ID=0x92 Node=0x11 Uid=0 Gid=0 Pid=19936] uid=33 gid=0 handle=INVALID-0x0
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: >Setattr: err=<nil>
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: Attr: 
2022/06/28 00:07:28 DEBUG : .user.ini.cT0lwJ: >Attr: a=valid=1s ino=0 size=101 mode=-rw-rw-r--, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Rename: oldName=".user.ini.cT0lwJ", newName=".user.ini", newDir=/
2022/06/28 00:07:28 INFO  : .user.ini.cT0lwJ: vfs cache: renamed in cache to ".user.ini"
2022/06/28 00:07:28 DEBUG : .user.ini: Updating file with <nil> 0xc000227e00
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vDel: ".user.ini.cT0lwJ"
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vAddFile: ".user.ini"
2022/06/28 00:07:28 DEBUG : /: >Rename: err=<nil>
2022/06/28 00:07:28 DEBUG : /: Invalidating ".user.ini"
2022/06/28 00:07:28 DEBUG : AUTHORS: Open: flags=OpenReadOnly
2022/06/28 00:07:28 DEBUG : AUTHORS: Open: flags=O_RDONLY
2022/06/28 00:07:28 DEBUG : AUTHORS: newRWFileHandle: 
2022/06/28 00:07:28 DEBUG : AUTHORS: >newRWFileHandle: err=<nil>
2022/06/28 00:07:28 DEBUG : AUTHORS: >Open: fd=AUTHORS (rw), err=<nil>
2022/06/28 00:07:28 DEBUG : AUTHORS: >Open: fh=&{AUTHORS (rw)}, err=<nil>
2022/06/28 00:07:28 DEBUG : /: Lookup: name=".AUTHORS.UTV9fI"
2022/06/28 00:07:28 DEBUG : /: >Lookup: node=<nil>, err=no such file or directory
2022/06/28 00:07:28 DEBUG : /: Create: name=".AUTHORS.UTV9fI"
2022/06/28 00:07:28 DEBUG : .AUTHORS.UTV9fI: Open: flags=O_RDWR|O_CREATE|O_EXCL
2022/06/28 00:07:28 DEBUG : .AUTHORS.UTV9fI: newRWFileHandle: 
2022/06/28 00:07:28 DEBUG : .AUTHORS.UTV9fI(0xc001a6be00): openPending: 
2022/06/28 00:07:28 DEBUG : .AUTHORS.UTV9fI: vfs cache: truncate to size=0
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vAddFile: ".AUTHORS.UTV9fI"
2022/06/28 00:07:28 DEBUG : .AUTHORS.UTV9fI(0xc001a6be00): >openPending: err=<nil>
2022/06/28 00:07:28 DEBUG : .AUTHORS.UTV9fI: >newRWFileHandle: err=<nil>
2022/06/28 00:07:28 DEBUG : : Added virtual directory entry vAddFile: ".AUTHORS.UTV9fI"
2022/06/28 00:07:28 DEBUG : .AUTHORS.UTV9fI: >Open: fd=.AUTHORS.UTV9fI (rw), err=<nil>

Here I am uploading graphs from google cloud showing my drive api usage:-

Traffic by response code
Traffic by response code1836×440 48.3 KB

Traffic
Traffic892×480 18 KB

2

Which file is that? How big is it? How are you uploading it?

Looks like it wants you to run the nextcloud container as root.

I don't see anything immediately wrong with the log.

You appear to be serving the nextcloud web frontend from google drive?

I'm confused as to what you are trying to acheive.

3

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