nextcloud / nextcloudpi

📦 Build code for NextcloudPi: Raspberry Pi, Odroid, Rock64, curl installer...
https://nextcloudpi.com
2.49k stars 295 forks source link

Upgrade NCP 1.39.0/NC 21.0.4 fail #1326

Closed vcbranco closed 2 years ago

vcbranco commented 3 years ago

The upgrade does not done.

During upgrade I have the following errors just after the line "System config value trusted_proxies => 12 set to string ::1"

✓ redis is configured ✓ push server is receiving redis messages ✓ push server can load mount info from database 🗴 push server can't connect to the Nextcloud server error sending request for url (https://10.8.6.100/index.php/apps/notify_push/test/cookie): error trying to connect: invalid dnsname: error trying to connect: invalid dnsname: invalid dnsname Abort

Clean up... Rolling back to backup /var/www/nextcloud-bkp_20210905_1630827743-20.0.2.2.tar.gz... {"reqId":"g2uhEBMHYLKFdYG1047b","level":2,"time":"2021-09-05T07:45:50+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"21.0.4.1"} {"reqId":"g2uhEBMHYLKFdYG1047b","level":2,"time":"2021-09-05T07:45:50+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"21.0.4.1"} check free space... extracting backup file /var/www/nextcloud-bkp_20210905_1630827743-20.0.2.2.tar.gz... restore files... restore database... No datadir found in backup Maintenance mode disabled Starting scan for user 1 out of 1 (ncp) +---------+-------+--------------+ | Folders | Files | Elapsed time | +---------+-------+--------------+ | 2 | 0 | 00:00:00 | +---------+-------+--------------+ System config value tempdirectory set to string /var/www/nextcloud/data/tmp System config value logfile set to string /var/www/nextcloud/data/nextcloud.log System config value trusted_domains => 11 set to string 176.78.117.244 System config value trusted_domains => 1 set to string 10.8.6.100 Scanning AppData for files

+---------+-------+--------------+ | Folders | Files | Elapsed time | +---------+-------+--------------+ | 5 | 4 | 00:00:00 | +---------+-------+--------------+ Cleanup... Rollback successful. Nothing was updated Done. Press any key...

nachoparker commented 3 years ago

many thanks for testing. Can you share the output of sudo ncp-report please?

nachoparker commented 3 years ago

also, is this your main instance, or is this a test instance you have around?

nachoparker commented 3 years ago

I made a special branch to debug your issue. That url https://10.8.6.100/index.php/apps/notify_push/test/cookie seems plain wrong.

Do you mind doing sudo ncp-update nc-21-vcbranco and trying again sudo ncp-update-nc 21.0.4, please?

We should get more info from the output this time around

vcbranco commented 3 years ago

This is a test instance (RPI 4 4GB) with the NextCloudPi_RPi_11-27-20 image fully updated.

I'll do all the tests and place the output here

ovpc commented 3 years ago

Like wise here on a VM (Proxmox), got rollback: terminal output at https://pastebin.com/59CHhBJ7

WeiChihChern commented 3 years ago

Host: M1 Mac Mini Docker image: ownyourbits/nextcloudpi-arm64:latest Note: Fresh docker run without any data

  1. Updated apps and nextcloud from 18.0.3 to 20.0.12 first.
  2. ncp-update nc-21-vcbranco. Successful, NCP to version 1.39.0.
  3. ncp-update-nc 21.0.4. Error message shown as below:

root@c5c3b7795ebe:/# ncp-update-nc 21.0.4 Current Nextcloud version 20.0.12.1 Available Nextcloud version 21.0.4 Download Nextcloud 21.0.4... Back up current instance... check free space... Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode already enabled backup database... backup files... tar: Nextcloud or one of the apps require upgrade - only a limited number of commands are available\nYou may use your browser or the occ upgrade command to do the upgrade\n/data/nextcloud: Cannot open: No such file or directory tar: Error is not recoverable: exiting now error generating backup Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode disabled Error backing up Clean up...

  1. ncp-report as shown below:
NextCloudPi diagnostics ``` NextCloudPi version v1.39.0 NextCloudPi image NextCloudPi_docker_01-19-21 distribution Debian GNU/Linux 10 \n \l automount no USB devices none datadir /data/nextcloud/data data in SD yes data filesystem overlayfs data disk usage 21G/24G rootfs usage 21G/24G swapfile /swap dbdir /data/database Nextcloud check ok Nextcloud version 20.0.12.1 HTTPD service up PHP service up MariaDB service up Redis service up Postfix service up internet check ok port check 80 closed port check 443 closed IP ***REMOVED SENSITIVE VALUE*** gateway ***REMOVED SENSITIVE VALUE*** interface eth0 certificates ***REMOVED SENSITIVE VALUE*** NAT loopback no uptime 4days ```
Nextcloud configuration ``` Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade { "system": { "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": { "0": "localhost", "5": "nextcloudpi.local", "7": "nextcloudpi", "8": "nextcloudpi.lan", "1": "172.17.0.3", "6": "192.168.1.65" }, "datadirectory": "***REMOVED SENSITIVE VALUE***", "dbtype": "mysql", "version": "18.0.3.0", "overwrite.cli.url": "http:\/\/localhost", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "mysql.utf8mb4": true, "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "installed": true, "instanceid": "***REMOVED SENSITIVE VALUE***", "memcache.local": "\\OC\\Memcache\\Redis", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0, "password": "***REMOVED SENSITIVE VALUE***" }, "tempdirectory": "\/var\/www\/nextcloud\/data\/tmp", "mail_smtpmode": "sendmail", "mail_smtpauthtype": "LOGIN", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "preview_max_x": "2048", "preview_max_y": "2048", "jpeg_quality": "60", "overwriteprotocol": "https", "maintenance": false, "loglevel": 2 } } ```
HTTPd logs ``` [Sun Sep 05 19:32:59.199611 2021] [authz_host:error] [pid 30552:tid 281473407099280] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /js/minified.js failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.199645 2021] [authz_host:error] [pid 30552:tid 281473381921168] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /js/ncp.js failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.200985 2021] [authz_host:error] [pid 30552:tid 281473398706576] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/loading-small.gif failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.201279 2021] [authz_host:error] [pid 30552:tid 281473390313872] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/ncp-logo.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.215652 2021] [authz_host:error] [pid 30552:tid 281473390313872] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/toggle.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.216059 2021] [authz_host:error] [pid 30552:tid 281473390313872] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/defaults.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.242567 2021] [authz_host:error] [pid 30552:tid 281473390313872] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/poweroff.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.242638 2021] [authz_host:error] [pid 30552:tid 281473398706576] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/reboot.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.252873 2021] [authz_host:error] [pid 30552:tid 281473398706576] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/search.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.252923 2021] [authz_host:error] [pid 30552:tid 281473390313872] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/nc-button.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.252993 2021] [authz_host:error] [pid 30552:tid 281473398706576] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/dashboard.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.254529 2021] [authz_host:error] [pid 30552:tid 281473407099280] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/defaults-white.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.254594 2021] [authz_host:error] [pid 30552:tid 281473407099280] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/settings-white.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.255172 2021] [authz_host:error] [pid 30552:tid 281473390313872] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/wizard.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.256581 2021] [authz_host:error] [pid 30552:tid 281473407099280] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/info-white.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.257503 2021] [authz_host:error] [pid 30552:tid 281473407099280] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /img/files.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.263936 2021] [authz_host:error] [pid 30552:tid 281473407099280] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name [Sun Sep 05 19:32:59.276940 2021] [authz_host:error] [pid 30552:tid 281473390313872] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /ncp-output.php failed, reason: unable to get the remote host name [Sun Sep 05 19:33:04.767493 2021] [authz_host:error] [pid 30552:tid 281473407099280] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name [Sun Sep 05 19:33:04.780003 2021] [authz_host:error] [pid 30552:tid 281473407099280] [client 172.17.0.1:63586] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name ```
Database logs ``` 2021-09-05 19:23:23 0 [ERROR] mysqld: Table './mysql/user' is marked as crashed and should be repaired 2021-09-05 19:23:23 0 [Warning] Checking table: './mysql/user' 2021-09-05 19:23:23 0 [ERROR] mysql.user: 1 client is using or hasn't closed the table properly 2021-09-05 19:23:23 0 [ERROR] mysqld: Table './mysql/db' is marked as crashed and should be repaired 2021-09-05 19:23:23 0 [Warning] Checking table: './mysql/db' 2021-09-05 19:23:23 0 [ERROR] mysql.db: 1 client is using or hasn't closed the table properly 2021-09-05 19:23:23 0 [Note] Reading of all Master_info entries succeeded 2021-09-05 19:23:23 0 [Note] Added new Master_info '' to hash table 2021-09-05 19:23:23 0 [Note] mysqld: ready for connections. Version: '10.3.22-MariaDB-0+deb10u1' socket: '/run/mysqld/mysqld.sock' port: 3306 Debian 10 2021-09-05 19:23:25 0 [Note] mysqld (initiated by: root[root] @ localhost []): Normal shutdown 2021-09-05 19:23:25 0 [Note] Event Scheduler: Purging the queue. 0 events 2021-09-05 19:23:25 0 [Note] InnoDB: FTS optimize thread exiting. 2021-09-05 19:23:25 0 [Note] InnoDB: Starting shutdown... 2021-09-05 19:23:25 0 [Note] InnoDB: Dumping buffer pool(s) to /data/database/ib_buffer_pool 2021-09-05 19:23:25 0 [Note] InnoDB: Buffer pool(s) dump completed at 210905 19:23:25 2021-09-05 19:23:27 0 [Note] InnoDB: Shutdown completed; log sequence number 4296968; transaction id 2780 2021-09-05 19:23:27 0 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1" 2021-09-05 19:23:27 0 [Note] mysqld: Shutdown complete ```
Nextcloud logs ``` {"reqId":"jrQgQkRWZTJDAgpNqAqf","level":2,"time":"2021-09-05T19:32:02+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"jrQgQkRWZTJDAgpNqAqf","level":2,"time":"2021-09-05T19:32:02+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"hTuojUtdLFlQ9VsOawHd","level":2,"time":"2021-09-05T19:32:59+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"hTuojUtdLFlQ9VsOawHd","level":2,"time":"2021-09-05T19:32:59+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"dlI2WmhuaFwjbkxOV1zM","level":2,"time":"2021-09-05T19:33:22+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"dlI2WmhuaFwjbkxOV1zM","level":2,"time":"2021-09-05T19:33:22+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"XO2MQhSgkZB4W7ksenSA","level":2,"time":"2021-09-05T19:33:22+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"XO2MQhSgkZB4W7ksenSA","level":2,"time":"2021-09-05T19:33:22+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"1lr0SxgyhahzO5hapqXI","level":2,"time":"2021-09-05T19:35:01+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"1lr0SxgyhahzO5hapqXI","level":2,"time":"2021-09-05T19:35:01+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"y8iTNXDHrT4PUUts0nkg","level":2,"time":"2021-09-05T19:35:43+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"y8iTNXDHrT4PUUts0nkg","level":2,"time":"2021-09-05T19:35:43+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"gHvUtZkyTHe1zURaNCjx","level":2,"time":"2021-09-05T19:35:44+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"gHvUtZkyTHe1zURaNCjx","level":2,"time":"2021-09-05T19:35:44+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"Vl0Wtlcx4S77JD0faG5a","level":2,"time":"2021-09-05T19:35:44+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"Vl0Wtlcx4S77JD0faG5a","level":2,"time":"2021-09-05T19:35:44+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"0xC5lQiAlAK97ppchHK2","level":2,"time":"2021-09-05T19:37:10+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"0xC5lQiAlAK97ppchHK2","level":2,"time":"2021-09-05T19:37:10+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"0COkiijVbO2OEpQdfRT4","level":2,"time":"2021-09-05T19:37:15+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"0COkiijVbO2OEpQdfRT4","level":2,"time":"2021-09-05T19:37:15+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} ```
WeiChihChern commented 3 years ago

2nd try.

  1. Updated apps and NCP to 1.38.6.
  2. Update NC from 18.0.3 to 20.0.12.
  3. Update NC from 20.0.12 to 21.0.4 Failed. Run the update again, then showing 'Nextcloud data directory not found'.
  4. ncp-report:
    NextCloudPi diagnostics

{"reqId":"6jNcTch5ypYv98ojjUT7","level":2,"time":"2021-09-05T19:54:03+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"}
{"reqId":"6jNcTch5ypYv98ojjUT7","level":2,"time":"2021-09-05T19:54:03+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"}
NextCloudPi version  v1.38.6
NextCloudPi image    NextCloudPi_docker_01-19-21
distribution         Debian GNU/Linux 10 \n \l
automount            no
USB devices          none
datadir              /data/nextcloud/data (doesn't exist)
rootfs usage         21G/24G
swapfile             /swap
dbdir                /data/database
Nextcloud check      ok
Nextcloud version    20.0.12.1
HTTPD service        up
PHP service          up
MariaDB service      up
Redis service        up
Postfix service      up
internet check       ok
port check 80        closed
port check 443       closed
IP                   ***REMOVED SENSITIVE VALUE***
gateway              ***REMOVED SENSITIVE VALUE***
interface            eth0
certificates         ***REMOVED SENSITIVE VALUE***
NAT loopback         no
uptime               4days

Nextcloud configuration ``` Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade { "system": { "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": { "0": "localhost", "5": "nextcloudpi.local", "7": "nextcloudpi", "8": "nextcloudpi.lan", "1": "172.17.0.3", "6": "192.168.1.65" }, "datadirectory": "***REMOVED SENSITIVE VALUE***", "dbtype": "mysql", "version": "18.0.3.0", "overwrite.cli.url": "http:\/\/localhost", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "mysql.utf8mb4": true, "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "installed": true, "instanceid": "***REMOVED SENSITIVE VALUE***", "memcache.local": "\\OC\\Memcache\\Redis", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0, "password": "***REMOVED SENSITIVE VALUE***" }, "tempdirectory": "\/var\/www\/nextcloud\/data\/tmp", "mail_smtpmode": "sendmail", "mail_smtpauthtype": "LOGIN", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "preview_max_x": "2048", "preview_max_y": "2048", "jpeg_quality": "60", "overwriteprotocol": "https", "maintenance": true, "loglevel": 2 } } ```
HTTPd logs ``` [Sun Sep 05 19:51:05.753198 2021] [authz_host:error] [pid 5438:tid 281473532907920] [client 172.17.0.1:56104] AH01753: access check of 'localhost' to /activate/JS.js failed, reason: unable to get the remote host name [Sun Sep 05 19:51:05.753378 2021] [authz_host:error] [pid 5438:tid 281473524515216] [client 172.17.0.1:56104] AH01753: access check of 'localhost' to /js/minified.js failed, reason: unable to get the remote host name [Sun Sep 05 19:51:05.754221 2021] [authz_host:error] [pid 5438:tid 281473541300624] [client 172.17.0.1:56104] AH01753: access check of 'localhost' to /img/loading-small.gif failed, reason: unable to get the remote host name [Sun Sep 05 19:51:05.755064 2021] [authz_host:error] [pid 5438:tid 281473616834960] [client 172.17.0.1:56104] AH01753: access check of 'localhost' to /img/clippy.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:51:05.755309 2021] [authz_host:error] [pid 5438:tid 281473549693328] [client 172.17.0.1:56104] AH01753: access check of 'localhost' to /img/background.png failed, reason: unable to get the remote host name [Sun Sep 05 19:51:05.755708 2021] [authz_host:error] [pid 5438:tid 281473558086032] [client 172.17.0.1:56104] AH01753: access check of 'localhost' to /img/ncp-logo.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:52:28.673088 2021] [authz_host:error] [pid 5437:tid 281473524515216] [client 172.17.0.1:56440] AH01753: access check of 'localhost' to /activate/ failed, reason: unable to get the remote host name [Sun Sep 05 19:52:28.673520 2021] [authz_host:error] [pid 5437:tid 281473524515216] [client 172.17.0.1:56440] AH01753: access check of 'localhost' to /activate/index.php failed, reason: unable to get the remote host name [Sun Sep 05 19:52:28.693921 2021] [authz_host:error] [pid 5437:tid 281473524515216] [client 172.17.0.1:56440] AH01753: access check of 'localhost' to /activate/CSS.css failed, reason: unable to get the remote host name [Sun Sep 05 19:52:28.699932 2021] [authz_host:error] [pid 5437:tid 281473532907920] [client 172.17.0.1:56440] AH01753: access check of 'localhost' to /img/ncp-logo.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:52:28.700282 2021] [authz_host:error] [pid 5437:tid 281473524515216] [client 172.17.0.1:56440] AH01753: access check of 'localhost' to /js/minified.js failed, reason: unable to get the remote host name [Sun Sep 05 19:52:28.704427 2021] [authz_host:error] [pid 5437:tid 281473541300624] [client 172.17.0.1:56440] AH01753: access check of 'localhost' to /img/clippy.svg failed, reason: unable to get the remote host name [Sun Sep 05 19:52:28.707401 2021] [authz_host:error] [pid 5437:tid 281473532907920] [client 172.17.0.1:56440] AH01753: access check of 'localhost' to /img/loading-small.gif failed, reason: unable to get the remote host name [Sun Sep 05 19:52:28.708289 2021] [authz_host:error] [pid 5437:tid 281473532907920] [client 172.17.0.1:56440] AH01753: access check of 'localhost' to /img/background.png failed, reason: unable to get the remote host name [Sun Sep 05 19:52:28.708954 2021] [authz_host:error] [pid 5437:tid 281473549693328] [client 172.17.0.1:56440] AH01753: access check of 'localhost' to /activate/JS.js failed, reason: unable to get the remote host name [Sun Sep 05 19:52:38.723763 2021] [mpm_event:notice] [pid 101:tid 281473840117104] AH00493: SIGUSR1 received. Doing graceful restart [Sun Sep 05 19:52:38.728143 2021] [ssl:error] [pid 101:tid 281473840117104] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=localhost / issuer: CN=localhost / serial: 5285EFBE66BF712AEC0DE78450C9537C14A3F5C3 / notbefore: Apr 6 07:00:05 2020 GMT / notafter: Apr 4 07:00:05 2030 GMT] [Sun Sep 05 19:52:38.728156 2021] [ssl:error] [pid 101:tid 281473840117104] AH02604: Unable to configure certificate localhost:443:0 for stapling [Sun Sep 05 19:52:38.728561 2021] [mpm_event:notice] [pid 101:tid 281473840117104] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Sun Sep 05 19:52:38.728573 2021] [core:notice] [pid 101:tid 281473840117104] AH00094: Command line: '/usr/sbin/apache2' ```
Database logs ``` 2021-09-05 19:46:54 0 [ERROR] mysqld: Table './mysql/user' is marked as crashed and should be repaired 2021-09-05 19:46:54 0 [Warning] Checking table: './mysql/user' 2021-09-05 19:46:54 0 [ERROR] mysql.user: 1 client is using or hasn't closed the table properly 2021-09-05 19:46:54 0 [ERROR] mysqld: Table './mysql/db' is marked as crashed and should be repaired 2021-09-05 19:46:54 0 [Warning] Checking table: './mysql/db' 2021-09-05 19:46:54 0 [ERROR] mysql.db: 1 client is using or hasn't closed the table properly 2021-09-05 19:46:54 0 [Note] Reading of all Master_info entries succeeded 2021-09-05 19:46:54 0 [Note] Added new Master_info '' to hash table 2021-09-05 19:46:54 0 [Note] mysqld: ready for connections. Version: '10.3.22-MariaDB-0+deb10u1' socket: '/run/mysqld/mysqld.sock' port: 3306 Debian 10 2021-09-05 19:46:56 0 [Note] mysqld (initiated by: root[root] @ localhost []): Normal shutdown 2021-09-05 19:46:56 0 [Note] Event Scheduler: Purging the queue. 0 events 2021-09-05 19:46:56 0 [Note] InnoDB: FTS optimize thread exiting. 2021-09-05 19:46:56 0 [Note] InnoDB: Starting shutdown... 2021-09-05 19:46:56 0 [Note] InnoDB: Dumping buffer pool(s) to /data/database/ib_buffer_pool 2021-09-05 19:46:56 0 [Note] InnoDB: Buffer pool(s) dump completed at 210905 19:46:56 2021-09-05 19:46:58 0 [Note] InnoDB: Shutdown completed; log sequence number 4296968; transaction id 2780 2021-09-05 19:46:58 0 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1" 2021-09-05 19:46:58 0 [Note] mysqld: Shutdown complete ```
Nextcloud logs ``` {"reqId":"arEevnkhRuhqtm5xPDbr","level":2,"time":"2021-09-05T19:54:08+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"arEevnkhRuhqtm5xPDbr","level":2,"time":"2021-09-05T19:54:08+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} ```
WeiChihChern commented 3 years ago

Would it work if just build a new image with NC21? Just be so excited with NC21.

vcbranco commented 3 years ago

ncp-report after the failed upgrade (ncp-update devel)

NextCloudPi diagnostics ``` NextCloudPi version v1.39.0 NextCloudPi image NextCloudPi_11-27-20 distribution Debian GNU/Linux 10 \n \l automount no USB devices none datadir /var/www/nextcloud/data data in SD yes data filesystem ext2/ext3 data disk usage 3,0G/29G rootfs usage 3,0G/29G swapfile /dev/zram3 dbdir /var/lib/mysql Nextcloud check ok Nextcloud version 20.0.12.1 HTTPD service up PHP service up MariaDB service up Redis service up Postfix service up internet check ok port check 80 open port check 443 open IP ***REMOVED SENSITIVE VALUE*** gateway ***REMOVED SENSITIVE VALUE*** interface eth0 certificates ***REMOVED SENSITIVE VALUE*** NAT loopback no uptime 10min ```
Nextcloud configuration ``` { "system": { "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": { "0": "localhost", "5": "nextcloudpi.local", "7": "nextcloudpi", "8": "nextcloudpi.lan", "11": "176.78.117.244", "1": "10.8.6.100" }, "datadirectory": "***REMOVED SENSITIVE VALUE***", "dbtype": "mysql", "version": "20.0.12.1", "overwrite.cli.url": "https:\/\/10.8.6.100\/", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "mysql.utf8mb4": true, "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "installed": true, "instanceid": "***REMOVED SENSITIVE VALUE***", "memcache.local": "\\OC\\Memcache\\Redis", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0, "password": "***REMOVED SENSITIVE VALUE***" }, "tempdirectory": "\/var\/www\/nextcloud\/data\/tmp", "mail_smtpmode": "sendmail", "mail_smtpauthtype": "LOGIN", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "preview_max_x": "2048", "preview_max_y": "2048", "jpeg_quality": "60", "overwriteprotocol": "https", "htaccess.RewriteBase": "\/", "maintenance": false, "loglevel": 2, "logfile": "\/var\/www\/nextcloud\/data\/nextcloud.log", "data-fingerprint": "670ed085260430c05522c2c035a8d852" } } ```
HTTPd logs ``` [Sun Sep 05 13:54:45.786380 2021] [ssl:warn] [pid 677:tid 548560110960] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Sun Sep 05 13:54:45.786654 2021] [ssl:error] [pid 677:tid 548560110960] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=archlinux / issuer: CN=archlinux / serial: 0112307086B5A933D74576F54C8FD74C8207A8AF / notbefore: Nov 27 22:55:31 2020 GMT / notafter: Nov 25 22:55:31 2030 GMT] [Sun Sep 05 13:54:45.786675 2021] [ssl:error] [pid 677:tid 548560110960] AH02604: Unable to configure certificate localhost:4443:0 for stapling [Sun Sep 05 13:54:45.833937 2021] [ssl:warn] [pid 866:tid 548560110960] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Sun Sep 05 13:54:45.834141 2021] [ssl:error] [pid 866:tid 548560110960] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=archlinux / issuer: CN=archlinux / serial: 0112307086B5A933D74576F54C8FD74C8207A8AF / notbefore: Nov 27 22:55:31 2020 GMT / notafter: Nov 25 22:55:31 2030 GMT] [Sun Sep 05 13:54:45.834154 2021] [ssl:error] [pid 866:tid 548560110960] AH02604: Unable to configure certificate localhost:4443:0 for stapling [Sun Sep 05 13:54:45.837882 2021] [mpm_event:notice] [pid 866:tid 548560110960] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Sun Sep 05 13:54:45.837968 2021] [core:notice] [pid 866:tid 548560110960] AH00094: Command line: '/usr/sbin/apache2' [Sun Sep 05 20:05:15.492018 2021] [mpm_event:notice] [pid 866:tid 548560110960] AH00493: SIGUSR1 received. Doing graceful restart [Sun Sep 05 20:05:15.514323 2021] [ssl:warn] [pid 866:tid 548560110960] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Sun Sep 05 20:05:15.514472 2021] [ssl:error] [pid 866:tid 548560110960] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=archlinux / issuer: CN=archlinux / serial: 0112307086B5A933D74576F54C8FD74C8207A8AF / notbefore: Nov 27 22:55:31 2020 GMT / notafter: Nov 25 22:55:31 2030 GMT] [Sun Sep 05 20:05:15.514484 2021] [ssl:error] [pid 866:tid 548560110960] AH02604: Unable to configure certificate localhost:4443:0 for stapling [Sun Sep 05 20:05:15.515451 2021] [mpm_event:notice] [pid 866:tid 548560110960] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Sun Sep 05 20:05:15.515463 2021] [core:notice] [pid 866:tid 548560110960] AH00094: Command line: '/usr/sbin/apache2' [Sun Sep 05 20:10:53.648095 2021] [mpm_event:notice] [pid 866:tid 548560110960] AH00493: SIGUSR1 received. Doing graceful restart [Sun Sep 05 20:10:53.672953 2021] [ssl:warn] [pid 866:tid 548560110960] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Sun Sep 05 20:10:53.673169 2021] [ssl:error] [pid 866:tid 548560110960] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=archlinux / issuer: CN=archlinux / serial: 0112307086B5A933D74576F54C8FD74C8207A8AF / notbefore: Nov 27 22:55:31 2020 GMT / notafter: Nov 25 22:55:31 2030 GMT] [Sun Sep 05 20:10:53.673185 2021] [ssl:error] [pid 866:tid 548560110960] AH02604: Unable to configure certificate localhost:4443:0 for stapling [Sun Sep 05 20:10:53.674165 2021] [mpm_event:notice] [pid 866:tid 548560110960] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Sun Sep 05 20:10:53.674180 2021] [core:notice] [pid 866:tid 548560110960] AH00094: Command line: '/usr/sbin/apache2' ```
Database logs ``` 2021-09-05 13:54:45 0 [Note] InnoDB: Uses event mutexes 2021-09-05 13:54:45 0 [Note] InnoDB: Compressed tables use zlib 1.2.11 2021-09-05 13:54:45 0 [Note] InnoDB: Number of pools: 1 2021-09-05 13:54:45 0 [Note] InnoDB: Using generic crc32 instructions 2021-09-05 13:54:46 0 [Note] InnoDB: Initializing buffer pool, total size = 1G, instances = 1, chunk size = 128M 2021-09-05 13:54:46 0 [Note] InnoDB: Completed initialization of buffer pool 2021-09-05 13:54:46 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority(). 2021-09-05 13:54:46 0 [Note] InnoDB: 128 out of 128 rollback segments are active. 2021-09-05 13:54:46 0 [Note] InnoDB: Creating shared tablespace for temporary tables 2021-09-05 13:54:46 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ... 2021-09-05 13:54:46 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB. 2021-09-05 13:54:46 0 [Note] InnoDB: 10.3.29 started; log sequence number 8896968; transaction id 12817 2021-09-05 13:54:46 0 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool 2021-09-05 13:54:46 0 [Note] Plugin 'FEEDBACK' is disabled. 2021-09-05 13:54:46 0 [Note] Server socket created on IP: '127.0.0.1'. 2021-09-05 13:54:46 0 [Note] Reading of all Master_info entries succeeded 2021-09-05 13:54:46 0 [Note] Added new Master_info '' to hash table 2021-09-05 13:54:46 0 [Note] /usr/sbin/mysqld: ready for connections. Version: '10.3.29-MariaDB-0+deb10u1' socket: '/run/mysqld/mysqld.sock' port: 3306 Debian 10 2021-09-05 13:54:47 0 [Note] InnoDB: Buffer pool(s) load completed at 210905 13:54:47 ```
Nextcloud logs ``` {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Reset generated avatar flag","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Keep legacy encryption enabled","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Check encryption key format","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Remove old dashboard app config data","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Add job to cleanup the bruteforce entries","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Queue a one-time job to check for user uploaded certificates","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Repair DAV shares","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Add background job to set the lookup server share state for users","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:21+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::startCheckCodeIntegrity: Starting code integrity check...","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:33+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::finishedCheckCodeIntegrity: Finished code integrity check","userAgent":"--","version":"20.0.12.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:33+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::updateEnd: Update successful","userAgent":"--","version":"21.0.4.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:33+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::maintenanceDisabled: Turned off maintenance mode","userAgent":"--","version":"21.0.4.1"} {"reqId":"sMYHaKycFJSkgt3245VR","level":1,"time":"2021-09-05T19:10:33+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::resetLogLevel: Reset log level to Warning(2)","userAgent":"--","version":"21.0.4.1"} ```
vcbranco commented 3 years ago

Test with the instance ncp-update nc-21-vcbranco in the same image but clean (the card was cloned) Error:

Update successful Turned off maintenance mode Resetting log level Check indices of the share table. Check indices of the filecache table. Adding additional size index to the filecache table, this can take some time... Filecache table updated successfully. Check indices of the twofactor_providers table. Check indices of the login_flow_v2 table. Check indices of the whats_new table. Check indices of the cards table. Check indices of the cards_properties table. Check indices of the calendarobjects_props table. Check indices of the schedulingobjects table. Check indices of the oc_properties table. Check columns of the comments table. Done. Check primary keys. Done. All tables already up to date! ++ ncc status ++ grep version: ++ awk '{ print $3 }'

+---------+-------+--------------+ | Folders | Files | Elapsed time | +---------+-------+--------------+ | 32 | 74 | 00:00:00 | +---------+-------+--------------+ Cleanup... ++ [[ /var/www/nextcloud/data == \/\v\a\r\/\w\w\w\/\n\e\x\t\c\l\o\u\d\/\d\a\t\a ]] ++ rm -rf /var/www/nextcloud/data ++ mv -T /var/www/ncp-data.CqJsv5 /var/www/nextcloud/data ++ rm /var/www/nextcloud-bkp_20210905_1630872395-20.0.12.1.tar.gz ++ echo 'Rollback successful. Nothing was updated' Rollback successful. Nothing was updated ++ exit 1 Done. Press any key...

ncp-report

NextCloudPi diagnostics ``` NextCloudPi version v1.39.0 NextCloudPi image NextCloudPi_11-27-20 distribution Debian GNU/Linux 10 \n \l automount no USB devices none datadir /var/www/nextcloud/data data in SD yes data filesystem ext2/ext3 data disk usage 3,0G/29G rootfs usage 3,0G/29G swapfile /dev/zram3 dbdir /var/lib/mysql Nextcloud check ok Nextcloud version 20.0.12.1 HTTPD service up PHP service up MariaDB service up Redis service up Postfix service up internet check ok port check 80 open port check 443 open IP ***REMOVED SENSITIVE VALUE*** gateway ***REMOVED SENSITIVE VALUE*** interface eth0 certificates ***REMOVED SENSITIVE VALUE*** NAT loopback no uptime 10min ```
Nextcloud configuration ``` { "system": { "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": { "0": "localhost", "5": "nextcloudpi.local", "7": "nextcloudpi", "8": "nextcloudpi.lan", "11": "176.78.117.244", "1": "10.8.6.100" }, "datadirectory": "***REMOVED SENSITIVE VALUE***", "dbtype": "mysql", "version": "20.0.12.1", "overwrite.cli.url": "https:\/\/10.8.6.100\/", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "mysql.utf8mb4": true, "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "installed": true, "instanceid": "***REMOVED SENSITIVE VALUE***", "memcache.local": "\\OC\\Memcache\\Redis", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0, "password": "***REMOVED SENSITIVE VALUE***" }, "tempdirectory": "\/var\/www\/nextcloud\/data\/tmp", "mail_smtpmode": "sendmail", "mail_smtpauthtype": "LOGIN", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "preview_max_x": "2048", "preview_max_y": "2048", "jpeg_quality": "60", "overwriteprotocol": "https", "htaccess.RewriteBase": "\/", "maintenance": false, "loglevel": 2, "logfile": "\/var\/www\/nextcloud\/data\/nextcloud.log", "data-fingerprint": "a15c227ddb351b16daa9271412cb999f" } } ```
HTTPd logs ``` [Sun Sep 05 13:54:46.067329 2021] [ssl:warn] [pid 664:tid 547694970224] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Sun Sep 05 13:54:46.067716 2021] [ssl:error] [pid 664:tid 547694970224] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=archlinux / issuer: CN=archlinux / serial: 0112307086B5A933D74576F54C8FD74C8207A8AF / notbefore: Nov 27 22:55:31 2020 GMT / notafter: Nov 25 22:55:31 2030 GMT] [Sun Sep 05 13:54:46.067738 2021] [ssl:error] [pid 664:tid 547694970224] AH02604: Unable to configure certificate localhost:4443:0 for stapling [Sun Sep 05 13:54:46.108708 2021] [ssl:warn] [pid 861:tid 547694970224] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Sun Sep 05 13:54:46.108975 2021] [ssl:error] [pid 861:tid 547694970224] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=archlinux / issuer: CN=archlinux / serial: 0112307086B5A933D74576F54C8FD74C8207A8AF / notbefore: Nov 27 22:55:31 2020 GMT / notafter: Nov 25 22:55:31 2030 GMT] [Sun Sep 05 13:54:46.109011 2021] [ssl:error] [pid 861:tid 547694970224] AH02604: Unable to configure certificate localhost:4443:0 for stapling [Sun Sep 05 13:54:46.113006 2021] [mpm_event:notice] [pid 861:tid 547694970224] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Sun Sep 05 13:54:46.113103 2021] [core:notice] [pid 861:tid 547694970224] AH00094: Command line: '/usr/sbin/apache2' [Sun Sep 05 21:05:55.291924 2021] [mpm_event:notice] [pid 861:tid 547694970224] AH00493: SIGUSR1 received. Doing graceful restart [Sun Sep 05 21:05:55.314824 2021] [ssl:warn] [pid 861:tid 547694970224] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Sun Sep 05 21:05:55.314972 2021] [ssl:error] [pid 861:tid 547694970224] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=archlinux / issuer: CN=archlinux / serial: 0112307086B5A933D74576F54C8FD74C8207A8AF / notbefore: Nov 27 22:55:31 2020 GMT / notafter: Nov 25 22:55:31 2030 GMT] [Sun Sep 05 21:05:55.314984 2021] [ssl:error] [pid 861:tid 547694970224] AH02604: Unable to configure certificate localhost:4443:0 for stapling [Sun Sep 05 21:05:55.315919 2021] [mpm_event:notice] [pid 861:tid 547694970224] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Sun Sep 05 21:05:55.315931 2021] [core:notice] [pid 861:tid 547694970224] AH00094: Command line: '/usr/sbin/apache2' [Sun Sep 05 21:11:42.015244 2021] [mpm_event:notice] [pid 861:tid 547694970224] AH00493: SIGUSR1 received. Doing graceful restart [Sun Sep 05 21:11:42.039746 2021] [ssl:warn] [pid 861:tid 547694970224] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Sun Sep 05 21:11:42.039982 2021] [ssl:error] [pid 861:tid 547694970224] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=archlinux / issuer: CN=archlinux / serial: 0112307086B5A933D74576F54C8FD74C8207A8AF / notbefore: Nov 27 22:55:31 2020 GMT / notafter: Nov 25 22:55:31 2030 GMT] [Sun Sep 05 21:11:42.039998 2021] [ssl:error] [pid 861:tid 547694970224] AH02604: Unable to configure certificate localhost:4443:0 for stapling [Sun Sep 05 21:11:42.040992 2021] [mpm_event:notice] [pid 861:tid 547694970224] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Sun Sep 05 21:11:42.041008 2021] [core:notice] [pid 861:tid 547694970224] AH00094: Command line: '/usr/sbin/apache2' ```
Database logs ``` 2021-09-05 13:54:46 0 [Note] InnoDB: Uses event mutexes 2021-09-05 13:54:46 0 [Note] InnoDB: Compressed tables use zlib 1.2.11 2021-09-05 13:54:46 0 [Note] InnoDB: Number of pools: 1 2021-09-05 13:54:46 0 [Note] InnoDB: Using generic crc32 instructions 2021-09-05 13:54:46 0 [Note] InnoDB: Initializing buffer pool, total size = 1G, instances = 1, chunk size = 128M 2021-09-05 13:54:46 0 [Note] InnoDB: Completed initialization of buffer pool 2021-09-05 13:54:46 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority(). 2021-09-05 13:54:47 0 [Note] InnoDB: 128 out of 128 rollback segments are active. 2021-09-05 13:54:47 0 [Note] InnoDB: Creating shared tablespace for temporary tables 2021-09-05 13:54:47 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ... 2021-09-05 13:54:47 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB. 2021-09-05 13:54:47 0 [Note] InnoDB: 10.3.29 started; log sequence number 8896968; transaction id 12817 2021-09-05 13:54:47 0 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool 2021-09-05 13:54:47 0 [Note] Plugin 'FEEDBACK' is disabled. 2021-09-05 13:54:47 0 [Note] Server socket created on IP: '127.0.0.1'. 2021-09-05 13:54:47 0 [Note] Reading of all Master_info entries succeeded 2021-09-05 13:54:47 0 [Note] Added new Master_info '' to hash table 2021-09-05 13:54:47 0 [Note] /usr/sbin/mysqld: ready for connections. Version: '10.3.29-MariaDB-0+deb10u1' socket: '/run/mysqld/mysqld.sock' port: 3306 Debian 10 2021-09-05 13:54:47 0 [Note] InnoDB: Buffer pool(s) load completed at 210905 13:54:47 ```
Nextcloud logs ``` {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Reset generated avatar flag","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Keep legacy encryption enabled","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Check encryption key format","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Remove old dashboard app config data","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Add job to cleanup the bruteforce entries","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Queue a one-time job to check for user uploaded certificates","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Repair DAV shares","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Add background job to set the lookup server share state for users","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:11+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::startCheckCodeIntegrity: Starting code integrity check...","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:22+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::finishedCheckCodeIntegrity: Finished code integrity check","userAgent":"--","version":"20.0.12.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:22+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::updateEnd: Update successful","userAgent":"--","version":"21.0.4.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:22+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::maintenanceDisabled: Turned off maintenance mode","userAgent":"--","version":"21.0.4.1"} {"reqId":"xMjN7dikzYpVFsXMJ60M","level":1,"time":"2021-09-05T20:11:22+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::resetLogLevel: Reset log level to Warning(2)","userAgent":"--","version":"21.0.4.1"} ```
vcbranco commented 3 years ago

The second error ncp-report is at the end. It seems to me it's the same issue

WeiChihChern commented 3 years ago

part 3.

Telegram pinned update instruction result:

Running nc-update-nextcloud Current Nextcloud version 18.0.3.0 Available Nextcloud version 21.0.4 Download Nextcloud 21.0.4... Back up current instance... check free space... Maintenance mode enabled backup database... backup files... backup /var/www//nextcloud-bkp_20210906_1630894298.tar.gz generated Maintenance mode disabled Install Nextcloud 21.0.4... Restore data... Fix permissions... Upgrade... Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Setting log level to debug Turned on maintenance mode Exception: Updates between multiple major versions and downgrades are unsupported. Update failed Maintenance mode is kept active Resetting log level Abort Clean up... Rolling back to backup /var/www/nextcloud-bkp_20210906_1630894298-18.0.3.0.tar.gz... {"reqId":"y5pHOagKPrj1O9DNjmEO","level":2,"time":"2021-09-06T02:11:56+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"y5pHOagKPrj1O9DNjmEO","level":2,"time":"2021-09-06T02:11:56+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} Can only restore from ext/btrfs filesystems Rollback failed! Data left at /var/www/ncp-data.na7qHH Done. Press any key...

'ncp-report' logs:

NextCloudPi diagnostics ``` NextCloudPi version v1.39.0 NextCloudPi image NextCloudPi_docker_01-19-21 distribution Debian GNU/Linux 10 \n \l automount no USB devices none datadir /data/nextcloud/data data in SD yes data filesystem overlayfs data disk usage 21G/24G rootfs usage 21G/24G swapfile /swap dbdir /data/database Nextcloud check ok Nextcloud version 21.0.4.1 HTTPD service up PHP service up MariaDB service up Redis service up Postfix service up internet check ok port check 80 closed port check 443 closed IP ***REMOVED SENSITIVE VALUE*** gateway ***REMOVED SENSITIVE VALUE*** interface eth0 certificates ***REMOVED SENSITIVE VALUE*** NAT loopback no uptime 5days ```
Nextcloud configuration ``` Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade { "system": { "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": { "0": "localhost", "5": "nextcloudpi.local", "7": "nextcloudpi", "8": "nextcloudpi.lan", "1": "172.17.0.3", "6": "192.168.1.65" }, "datadirectory": "***REMOVED SENSITIVE VALUE***", "dbtype": "mysql", "version": "18.0.3.0", "overwrite.cli.url": "http:\/\/localhost", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "mysql.utf8mb4": true, "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "installed": true, "instanceid": "***REMOVED SENSITIVE VALUE***", "memcache.local": "\\OC\\Memcache\\Redis", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0, "password": "***REMOVED SENSITIVE VALUE***" }, "tempdirectory": "\/var\/www\/nextcloud\/data\/tmp", "mail_smtpmode": "sendmail", "mail_smtpauthtype": "LOGIN", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "preview_max_x": "2048", "preview_max_y": "2048", "jpeg_quality": "60", "overwriteprotocol": "https", "maintenance": true, "loglevel": 2 } } ```
HTTPd logs ``` [Mon Sep 06 02:09:43.311951 2021] [ssl:error] [pid 99:tid 281473370936688] AH02604: Unable to configure certificate localhost:443:0 for stapling [Mon Sep 06 02:09:43.315347 2021] [ssl:error] [pid 100:tid 281473370936688] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=localhost / issuer: CN=localhost / serial: 5285EFBE66BF712AEC0DE78450C9537C14A3F5C3 / notbefore: Apr 6 07:00:05 2020 GMT / notafter: Apr 4 07:00:05 2030 GMT] [Mon Sep 06 02:09:43.315356 2021] [ssl:error] [pid 100:tid 281473370936688] AH02604: Unable to configure certificate localhost:443:0 for stapling [Mon Sep 06 02:09:43.316183 2021] [mpm_event:notice] [pid 100:tid 281473370936688] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Mon Sep 06 02:09:43.316194 2021] [core:notice] [pid 100:tid 281473370936688] AH00094: Command line: '/usr/sbin/apache2' [Mon Sep 06 02:10:19.458752 2021] [mpm_event:notice] [pid 100:tid 281473370936688] AH00493: SIGUSR1 received. Doing graceful restart [Mon Sep 06 02:10:19.462459 2021] [ssl:error] [pid 100:tid 281473370936688] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=localhost / issuer: CN=localhost / serial: 5285EFBE66BF712AEC0DE78450C9537C14A3F5C3 / notbefore: Apr 6 07:00:05 2020 GMT / notafter: Apr 4 07:00:05 2030 GMT] [Mon Sep 06 02:10:19.462471 2021] [ssl:error] [pid 100:tid 281473370936688] AH02604: Unable to configure certificate localhost:443:0 for stapling [Mon Sep 06 02:10:19.462890 2021] [mpm_event:notice] [pid 100:tid 281473370936688] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Mon Sep 06 02:10:19.462898 2021] [core:notice] [pid 100:tid 281473370936688] AH00094: Command line: '/usr/sbin/apache2' [Mon Sep 06 02:10:19.679836 2021] [mpm_event:notice] [pid 100:tid 281473370936688] AH00493: SIGUSR1 received. Doing graceful restart [Mon Sep 06 02:10:19.683247 2021] [ssl:error] [pid 100:tid 281473370936688] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=localhost / issuer: CN=localhost / serial: 5285EFBE66BF712AEC0DE78450C9537C14A3F5C3 / notbefore: Apr 6 07:00:05 2020 GMT / notafter: Apr 4 07:00:05 2030 GMT] [Mon Sep 06 02:10:19.683258 2021] [ssl:error] [pid 100:tid 281473370936688] AH02604: Unable to configure certificate localhost:443:0 for stapling [Mon Sep 06 02:10:19.683614 2021] [mpm_event:notice] [pid 100:tid 281473370936688] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Mon Sep 06 02:10:19.683619 2021] [core:notice] [pid 100:tid 281473370936688] AH00094: Command line: '/usr/sbin/apache2' [Mon Sep 06 02:11:17.117736 2021] [mpm_event:notice] [pid 100:tid 281473370936688] AH00493: SIGUSR1 received. Doing graceful restart [Mon Sep 06 02:11:17.122160 2021] [ssl:error] [pid 100:tid 281473370936688] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=localhost / issuer: CN=localhost / serial: 5285EFBE66BF712AEC0DE78450C9537C14A3F5C3 / notbefore: Apr 6 07:00:05 2020 GMT / notafter: Apr 4 07:00:05 2030 GMT] [Mon Sep 06 02:11:17.122171 2021] [ssl:error] [pid 100:tid 281473370936688] AH02604: Unable to configure certificate localhost:443:0 for stapling [Mon Sep 06 02:11:17.122598 2021] [mpm_event:notice] [pid 100:tid 281473370936688] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Mon Sep 06 02:11:17.122604 2021] [core:notice] [pid 100:tid 281473370936688] AH00094: Command line: '/usr/sbin/apache2' ```
Database logs ``` 2021-09-06 2:09:43 0 [ERROR] mysqld: Table './mysql/user' is marked as crashed and should be repaired 2021-09-06 2:09:43 0 [Warning] Checking table: './mysql/user' 2021-09-06 2:09:43 0 [ERROR] mysql.user: 1 client is using or hasn't closed the table properly 2021-09-06 2:09:43 0 [ERROR] mysqld: Table './mysql/db' is marked as crashed and should be repaired 2021-09-06 2:09:43 0 [Warning] Checking table: './mysql/db' 2021-09-06 2:09:43 0 [ERROR] mysql.db: 1 client is using or hasn't closed the table properly 2021-09-06 2:09:43 0 [Note] Reading of all Master_info entries succeeded 2021-09-06 2:09:43 0 [Note] Added new Master_info '' to hash table 2021-09-06 2:09:43 0 [Note] mysqld: ready for connections. Version: '10.3.22-MariaDB-0+deb10u1' socket: '/run/mysqld/mysqld.sock' port: 3306 Debian 10 2021-09-06 2:09:45 0 [Note] mysqld (initiated by: root[root] @ localhost []): Normal shutdown 2021-09-06 2:09:45 0 [Note] Event Scheduler: Purging the queue. 0 events 2021-09-06 2:09:45 0 [Note] InnoDB: FTS optimize thread exiting. 2021-09-06 2:09:45 0 [Note] InnoDB: Starting shutdown... 2021-09-06 2:09:45 0 [Note] InnoDB: Dumping buffer pool(s) to /data/database/ib_buffer_pool 2021-09-06 2:09:45 0 [Note] InnoDB: Buffer pool(s) dump completed at 210906 2:09:45 2021-09-06 2:09:47 0 [Note] InnoDB: Shutdown completed; log sequence number 4296968; transaction id 2780 2021-09-06 2:09:47 0 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1" 2021-09-06 2:09:47 0 [Note] mysqld: Shutdown complete ```
Nextcloud logs ``` {"reqId":"QaPAdR4IssDJdJoZeLeo","level":2,"time":"2021-09-06T02:13:51+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"QaPAdR4IssDJdJoZeLeo","level":2,"time":"2021-09-06T02:13:51+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"tvPDA53vfkwfOVpynR0X","level":2,"time":"2021-09-06T02:13:56+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"tvPDA53vfkwfOVpynR0X","level":2,"time":"2021-09-06T02:13:56+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} ```
nachoparker commented 3 years ago

thanks all. Please bear with me, as upgrading to this new HPB is really proving to be a pain given all the moving pieces. Also I don't think it's super well polished.

I'll go with your issues one by one.

@vcbranco

A couple questions: Do you have nc-static-IP activated by any chance? do you access by IP or do you have a domain name to access?

I wasn't able to reproduce your issue, but I think we are dealing with this https://github.com/rustls/hyper-rustls/issues/84

In any case, please run again ncp-update nc-21-vcbranco and then ncp-update-nc 21.0.4, see if my fixes work for your case.


@WeiChihChern

Would it work if just build a new image with NC21? Just be so excited with NC21.

Yes, you can checkout devel and then ./build-docker.sh arm64, but then I still need to fix your issue before I can push this to everyone. A new set of images will come after this is good to go.

I'll try to replicate your upgrade path next

vcbranco commented 3 years ago

Yes, nc-static-ip is activated. This test intance is accessed by IP.

I going to start testing and post the results.

vcbranco commented 3 years ago

No luck Same problem

I'm going to setup a test DNS to the upgrade

vcbranco commented 3 years ago

Same problem.

Let's encrypt and nc-static-IP configured. Upgrade with ncp-update nc-21-vcbranco

Starting code integrity check... Finished code integrity check Update successful Turned off maintenance mode Resetting log level Check indices of the share table. Check indices of the filecache table. Adding additional size index to the filecache table, this can take some time... Filecache table updated successfully. Check indices of the twofactor_providers table. Check indices of the login_flow_v2 table. Check indices of the whats_new table. Check indices of the cards table. Check indices of the cards_properties table. Check indices of the calendarobjects_props table. Check indices of the schedulingobjects table. Check indices of the oc_properties table. Check columns of the comments table. Done. Check primary keys. Done. All tables already up to date! ++ ncc status ++ grep version: ++ awk '{ print $3 }'

+---------+-------+--------------+ | Folders | Files | Elapsed time | +---------+-------+--------------+ | 21 | 41 | 00:00:00 | +---------+-------+--------------+ Cleanup... ++ [[ /var/www/nextcloud/data == \/\v\a\r\/\w\w\w\/\n\e\x\t\c\l\o\u\d\/\d\a\t\a ]] ++ rm -rf /var/www/nextcloud/data ++ mv -T /var/www/ncp-data.tHNbAO /var/www/nextcloud/data ++ rm /var/www/nextcloud-bkp_20210907_1631037354-20.0.12.1.tar.gz ++ echo 'Rollback successful. Nothing was updated' Rollback successful. Nothing was updated ++ exit 1 Done. Press any key...

ncp-report

NextCloudPi diagnostics ``` NextCloudPi version v1.39.0 NextCloudPi image NextCloudPi_11-27-20 distribution Debian GNU/Linux 10 \n \l automount no USB devices none datadir /var/www/nextcloud/data data in SD yes data filesystem ext2/ext3 data disk usage 2.6G/29G rootfs usage 2.6G/29G swapfile /var/swap dbdir /var/lib/mysql Nextcloud check ok Nextcloud version 20.0.12.1 HTTPD service up PHP service up MariaDB service up Redis service up Postfix service up internet check ok port check 80 open port check 443 open IP ***REMOVED SENSITIVE VALUE*** gateway ***REMOVED SENSITIVE VALUE*** interface eth0 certificates ***REMOVED SENSITIVE VALUE*** NAT loopback no uptime 31min ```
Nextcloud configuration ``` { "system": { "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": { "0": "localhost", "5": "nextcloudpi.local", "7": "nextcloudpi", "8": "nextcloudpi.lan", "11": "176.78.117.244", "1": "10.8.6.100", "12": "pi.emcontacto.eu" }, "datadirectory": "***REMOVED SENSITIVE VALUE***", "dbtype": "mysql", "version": "20.0.12.1", "overwrite.cli.url": "https:\/\/pi.emcontacto.eu\/", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "mysql.utf8mb4": true, "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "installed": true, "instanceid": "***REMOVED SENSITIVE VALUE***", "memcache.local": "\\OC\\Memcache\\Redis", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0, "password": "***REMOVED SENSITIVE VALUE***" }, "tempdirectory": "\/var\/www\/nextcloud\/data\/tmp", "mail_smtpmode": "sendmail", "mail_smtpauthtype": "LOGIN", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "preview_max_x": "2048", "preview_max_y": "2048", "jpeg_quality": "60", "overwriteprotocol": "https", "maintenance": false, "loglevel": 2, "htaccess.RewriteBase": "\/", "logfile": "\/var\/www\/nextcloud\/data\/nextcloud.log", "data-fingerprint": "a417da10d7b92c37024a3cfac59e505f" } } ```
HTTPd logs ``` [Tue Sep 07 18:31:40.246782 2021] [ssl:warn] [pid 864:tid 547993838960] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Tue Sep 07 18:31:40.247027 2021] [ssl:error] [pid 864:tid 547993838960] AH02217: ssl_stapling_init_cert: can't retrieve issuer certificate! [subject: CN=archlinux / issuer: CN=archlinux / serial: 0112307086B5A933D74576F54C8FD74C8207A8AF / notbefore: Nov 27 22:55:31 2020 GMT / notafter: Nov 25 22:55:31 2030 GMT] [Tue Sep 07 18:31:40.247051 2021] [ssl:error] [pid 864:tid 547993838960] AH02604: Unable to configure certificate localhost:4443:0 for stapling [Tue Sep 07 18:31:40.248167 2021] [mpm_event:notice] [pid 864:tid 547993838960] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Tue Sep 07 18:31:40.248193 2021] [core:notice] [pid 864:tid 547993838960] AH00094: Command line: '/usr/sbin/apache2' [Tue Sep 07 18:53:44.509161 2021] [mpm_event:notice] [pid 864:tid 547993838960] AH00493: SIGUSR1 received. Doing graceful restart [Tue Sep 07 18:53:44.532778 2021] [ssl:warn] [pid 864:tid 547993838960] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Tue Sep 07 18:53:44.534103 2021] [mpm_event:notice] [pid 864:tid 547993838960] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Tue Sep 07 18:53:44.534121 2021] [core:notice] [pid 864:tid 547993838960] AH00094: Command line: '/usr/sbin/apache2' [Tue Sep 07 18:55:07.058114 2021] [mpm_event:notice] [pid 864:tid 547993838960] AH00493: SIGUSR1 received. Doing graceful restart [Tue Sep 07 18:55:07.083004 2021] [ssl:warn] [pid 864:tid 547993838960] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Tue Sep 07 18:55:07.084280 2021] [mpm_event:notice] [pid 864:tid 547993838960] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Tue Sep 07 18:55:07.084294 2021] [core:notice] [pid 864:tid 547993838960] AH00094: Command line: '/usr/sbin/apache2' [Tue Sep 07 18:59:03.357859 2021] [mpm_event:notice] [pid 864:tid 547993838960] AH00493: SIGUSR1 received. Doing graceful restart [Tue Sep 07 18:59:03.387698 2021] [ssl:warn] [pid 864:tid 547993838960] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name [Tue Sep 07 18:59:03.389021 2021] [mpm_event:notice] [pid 864:tid 547993838960] AH00489: Apache/2.4.38 (Debian) OpenSSL/1.1.1d configured -- resuming normal operations [Tue Sep 07 18:59:03.389037 2021] [core:notice] [pid 864:tid 547993838960] AH00094: Command line: '/usr/sbin/apache2' ```
Database logs ``` ```
Nextcloud logs ``` {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Reset generated avatar flag","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Keep legacy encryption enabled","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Check encryption key format","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Remove old dashboard app config data","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Add job to cleanup the bruteforce entries","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Queue a one-time job to check for user uploaded certificates","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Repair DAV shares","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Deprecated event type for \\OC\\Repair::step: Symfony\\Component\\EventDispatcher\\GenericEvent is used","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Repair::step: Repair step: Add background job to set the lookup server share state for users","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:40+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::startCheckCodeIntegrity: Starting code integrity check...","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:47+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::finishedCheckCodeIntegrity: Finished code integrity check","userAgent":"--","version":"20.0.12.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:47+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::updateEnd: Update successful","userAgent":"--","version":"21.0.4.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:47+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::maintenanceDisabled: Turned off maintenance mode","userAgent":"--","version":"21.0.4.1"} {"reqId":"cnLkATFExBhpXtfOzLJM","level":1,"time":"2021-09-07T17:58:47+00:00","remoteAddr":"","user":"--","app":"updater","method":"","url":"--","message":"\\OC\\Updater::resetLogLevel: Reset log level to Warning(2)","userAgent":"--","version":"21.0.4.1"} ```
WeiChihChern commented 3 years ago

@nachoparker Thanks for the feedback. I've build an image from the devel branch. My personal NCP is running with the older image with an external hard drive. Can I simply stop the old image, and launch the new image and mount the external drive?

Or further setup is required to switch from one image to another with data all in an external drive? Thanks.

nachoparker commented 3 years ago

@WeiChihChern that's not how it works, if you want to retain your users, data and so on you need to upgrade, no way around that.

Updated apps and nextcloud from 18.0.3 to 20.0.12 first.

How did you do this? through NC updater or through NCP tools? it seems like you were in a half updated state. I updated from 18 to 20 and then did ncp-update nc-21-vcbranco and then upgraded to 21 all using NCP tools and it worked fine for me.

@vcbranco thanks for your testing. You never shared the output from your second attempt with static IP so I don't know how it went. You just said it didn't work. Then you changed your setup and you shared the output, so we are mixing things here and I cannot trace whether my fix worked or needs adjustments.

I'm going to setup a test DNS to the upgrade

what does this mean? on your last output I see https://pi.emcontacto.eu in overwrite.cli.url, but I don't know where it comes from. notify_push seems to have a problem with it. Are you behind a proxy? have you messed with the 'forwarded_for_headers' option in your config.php by any chance?

WeiChihChern commented 3 years ago

@nachoparker I see. I wonder what if one encountered power shortage to his device and have to relaunch the docker container again? Does that mean the users, data, etc cannot be retained? Does it mean docker users are encouraged to docker commit their image regularly? Thanks.

I updated apps and nextcloud using ncp-config. I would try it again using your instructions, see how it goes.

nachoparker commented 3 years ago

@ovpc if your proxmox VM is disposable (only if), can you also ncp-update nc-21-vcbranco, then edit /usr/local/bin/ncp-update-nc and remove the line that says set-nc-domain "${nc_domain}", then

ncp-update-nc 21.0.4 # should finish ok this time, but notify_push won't be setup yet
ncc notify_push:log debug
source /usr/local/etc/library.sh
set -x
set-nc-domain localhost
journalctl -u notify_push # hopefully there's some debug info here

You error is super weird and super unhelpful and I can't find what library it comes from :/

Thanks

nachoparker commented 3 years ago

@WeiChihChern not encouraged to docker commit, your NC instance, database and data need to be in sync and they live in a volume so that's orthogonal to what image you are using, and that means that they are retained always, but they are independent on the underlying docker image, because they need to be in sync. You cannot upgrade NC without migrating the database, apps and so on.

WeiChihChern commented 3 years ago

@nachoparker Tried again, but having the error of:

Running nc-update-nextcloud Current Nextcloud version 20.0.4.0 Available Nextcloud version 21.0.4 Download Nextcloud 21.0.4... Back up current instance... check free space... Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode enabled backup database... backup files... tar: Nextcloud or one of the apps require upgrade - only a limited number of commands are available\nYou may use your browser or the occ upgrade command to do the upgrade\n/data/nextcloud: Cannot open: No such file or directory tar: Error is not recoverable: exiting now error generating backup Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode disabled Error backing up Clean up... Done. Press any key...

ncp-report:

NextCloudPi diagnostics ``` NextCloudPi version v1.39.0 NextCloudPi image NextCloudPi_docker_01-19-21 distribution Debian GNU/Linux 10 \n \l automount no USB devices none datadir /data/nextcloud/data data in SD yes data filesystem overlayfs data disk usage 23G/48G rootfs usage 23G/48G swapfile /swap dbdir /data/database Nextcloud check ok Nextcloud version 20.0.4.0 HTTPD service up PHP service up MariaDB service up Redis service up Postfix service up internet check ok port check 80 closed port check 443 closed IP ***REMOVED SENSITIVE VALUE*** gateway ***REMOVED SENSITIVE VALUE*** interface eth0 certificates ***REMOVED SENSITIVE VALUE*** NAT loopback no uptime 7min ```
Nextcloud configuration ``` Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade { "system": { "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": { "0": "localhost", "5": "nextcloudpi.local", "7": "nextcloudpi", "8": "nextcloudpi.lan", "1": "172.17.0.2", "6": "192.168.1.65", "3": "nextcloudpi" }, "datadirectory": "***REMOVED SENSITIVE VALUE***", "dbtype": "mysql", "version": "18.0.3.0", "overwrite.cli.url": "https:\/\/nextcloudpi\/", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "mysql.utf8mb4": true, "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "installed": true, "instanceid": "***REMOVED SENSITIVE VALUE***", "memcache.local": "\\OC\\Memcache\\Redis", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0, "password": "***REMOVED SENSITIVE VALUE***" }, "tempdirectory": "\/var\/www\/nextcloud\/data\/tmp", "mail_smtpmode": "sendmail", "mail_smtpauthtype": "LOGIN", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "preview_max_x": "2048", "preview_max_y": "2048", "jpeg_quality": "60", "overwriteprotocol": "https", "maintenance": false, "loglevel": 2, "trusted_proxies": "***REMOVED SENSITIVE VALUE***" } } ```
HTTPd logs ``` [Wed Sep 08 02:15:46.874358 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/ncp-logo.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.882244 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /wizard/img/ncp-logo.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.886971 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/toggle.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.889035 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/defaults.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.911974 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/poweroff.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.911974 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/reboot.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.935732 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/view-close.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.936091 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/search.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.936607 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/nc-button.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.938924 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/defaults-white.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.938909 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/dashboard.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.939036 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/settings-white.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.939204 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/wizard.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.939963 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/info-white.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.941196 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/files.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.949438 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.949941 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-output.php failed, reason: unable to get the remote host name [Wed Sep 08 02:15:47.003203 2021] [authz_host:error] [pid 28812:tid 281472595276176] [client 172.17.0.1:65320] AH01753: access check of 'localhost' to /img/favicon.png failed, reason: unable to get the remote host name [Wed Sep 08 02:15:51.744702 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name [Wed Sep 08 02:15:51.758102 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name ```
Database logs ``` 2021-09-08 2:11:11 0 [ERROR] mysqld: Table './mysql/user' is marked as crashed and should be repaired 2021-09-08 2:11:11 0 [Warning] Checking table: './mysql/user' 2021-09-08 2:11:11 0 [ERROR] mysql.user: 1 client is using or hasn't closed the table properly 2021-09-08 2:11:11 0 [ERROR] mysqld: Table './mysql/db' is marked as crashed and should be repaired 2021-09-08 2:11:11 0 [Warning] Checking table: './mysql/db' 2021-09-08 2:11:11 0 [ERROR] mysql.db: 1 client is using or hasn't closed the table properly 2021-09-08 2:11:11 0 [Note] Reading of all Master_info entries succeeded 2021-09-08 2:11:11 0 [Note] Added new Master_info '' to hash table 2021-09-08 2:11:11 0 [Note] mysqld: ready for connections. Version: '10.3.22-MariaDB-0+deb10u1' socket: '/run/mysqld/mysqld.sock' port: 3306 Debian 10 2021-09-08 2:11:13 0 [Note] mysqld (initiated by: root[root] @ localhost []): Normal shutdown 2021-09-08 2:11:13 0 [Note] Event Scheduler: Purging the queue. 0 events 2021-09-08 2:11:13 0 [Note] InnoDB: FTS optimize thread exiting. 2021-09-08 2:11:13 0 [Note] InnoDB: Starting shutdown... 2021-09-08 2:11:13 0 [Note] InnoDB: Dumping buffer pool(s) to /data/database/ib_buffer_pool 2021-09-08 2:11:13 0 [Note] InnoDB: Buffer pool(s) dump completed at 210908 2:11:13 2021-09-08 2:11:14 0 [Note] InnoDB: Shutdown completed; log sequence number 4296968; transaction id 2780 2021-09-08 2:11:14 0 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1" 2021-09-08 2:11:14 0 [Note] mysqld: Shutdown complete ```
Nextcloud logs ``` {"reqId":"IXmnKavTbH4tUIuwdorz","level":2,"time":"2021-09-08T02:16:12+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"IXmnKavTbH4tUIuwdorz","level":2,"time":"2021-09-08T02:16:12+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"u7j9zdrfCZbmXkxOVav8","level":2,"time":"2021-09-08T02:16:12+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"u7j9zdrfCZbmXkxOVav8","level":2,"time":"2021-09-08T02:16:12+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"hDJpU3GLC47rAUeu6S0D","level":2,"time":"2021-09-08T02:16:12+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"hDJpU3GLC47rAUeu6S0D","level":2,"time":"2021-09-08T02:16:12+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"0yCzwe1PNcqnHzBl3A6D","level":2,"time":"2021-09-08T02:16:20+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"0yCzwe1PNcqnHzBl3A6D","level":2,"time":"2021-09-08T02:16:20+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"uGXvRUoI12SW88I17uKy","level":2,"time":"2021-09-08T02:16:20+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"uGXvRUoI12SW88I17uKy","level":2,"time":"2021-09-08T02:16:20+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"Vu8bf3Hg9sNvadt7krNc","level":2,"time":"2021-09-08T02:16:21+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"Vu8bf3Hg9sNvadt7krNc","level":2,"time":"2021-09-08T02:16:21+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"255DLePVTFb6dZgRLzFZ","level":2,"time":"2021-09-08T02:16:53+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"255DLePVTFb6dZgRLzFZ","level":2,"time":"2021-09-08T02:16:53+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"mARkF1B3KLj0140yRSeJ","level":2,"time":"2021-09-08T02:16:53+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"mARkF1B3KLj0140yRSeJ","level":2,"time":"2021-09-08T02:16:53+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"MMB6Y9DublrfXEiMGsmQ","level":2,"time":"2021-09-08T02:17:00+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"MMB6Y9DublrfXEiMGsmQ","level":2,"time":"2021-09-08T02:17:00+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"fLCsGzLmIdLpf4Rhyluz","level":2,"time":"2021-09-08T02:17:04+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"fLCsGzLmIdLpf4Rhyluz","level":2,"time":"2021-09-08T02:17:04+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} ```
WeiChihChern commented 3 years ago

@nachoparker

and that means that they are retained always

Sorry that I might not use the right words. I understand that the database would retain. In my case, in the external storage that -v into the container.

What I am not sure what to do is that, as mentioned if something like power shortage resulting in relaunching a container is required, what is the correct ways to migrate my database, user, etc into a newly launch container?

It could be:

  1. Using the provided docker image to start a fresh setup.
  2. Upgrade to NC 20, then have everything setup and users upload their files
  3. Encounter situations that need to restart a container
  4. The provided docker image has NC 18, which does not match my database What should I do in this case? Thanks.
nachoparker commented 3 years ago

@WeiChihChern it seems like your backup step is failing? can you just run a backup from ncp-config, see how that goes?

The provided docker image has NC 18, which does not match my database What should I do in this case? Thanks.

this is what you are not understanding I think, the image does not contain NC18. NC18 lives in a volume, along with the data and the database (and the apps). You can restart the container all you want, or you can even change container versions, as long as you include the same volume you will be in the same "NC instance" (but maybe with a different version of NCP tools). That's how we make sure we are always in sync.

WeiChihChern commented 3 years ago

@nachoparker backup log:

Running nc-backup check free space... Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode enabled backup database... backup files... tar: Nextcloud or one of the apps require upgrade - only a limited number of commands are available\nYou may use your browser or the occ upgrade command to do the upgrade\n/data/nextcloud: Cannot open: No such file or directory tar: Error is not recoverable: exiting now error generating backup Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode disabled Done. Press any key...

Ahh, now I understand it. Thanks for the explanation.

ovpc commented 3 years ago

@ovpc if your proxmox VM is disposable (only if), can you also ncp-update nc-21-vcbranco, then edit /usr/local/bin/ncp-update-nc and remove the line that says set-nc-domain "${nc_domain}", then

ncp-update-nc 21.0.4 # should finish ok this time, but notify_push won't be setup yet
ncc notify_push:log debug
source /usr/local/etc/library.sh
set -x
set-nc-domain localhost
journalctl -u notify_push # hopefully there's some debug info here

You error is super weird and super unhelpful and I can't find what library it comes from :/

Thanks

@nachoparker sorry this VM is not disposible. I will create a fresh one to test this, later on today.

ovpc commented 3 years ago

@nachoparker Could not reproduce the error on a new test VM it updated fine to 21.0.4 (see https://pastebin.com/8jWdiYqh) Got the old imagick error in NC admin settings tho

Security & setup warnings

This instance is missing some recommended PHP modules. For improved performance and better compatibility it is highly recommended to install them.

imagick
nachoparker commented 3 years ago

@ovpc can you just try again on your original VM? maybe it was a one time glitch :thinking:

@WeiChihChern can you add set -x to /usr/local/bin/ncp-backup as a second line and try to run a backup again?

WeiChihChern commented 3 years ago

@nachoparker Is this what you want?

root@bbb3f069dfbb:/# /usr/local/bin/ncp-backup \ -x Cannot load Zend OPcache - it was already loaded check free space... Cannot load Zend OPcache - it was already loaded Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode enabled backup database... backup files... tar: Nextcloud or one of the apps require upgrade - only a limited number of commands are available\nYou may use your browser or the occ upgrade command to do the upgrade\n/data/nextcloud: Cannot open: No such file or directory tar: Error is not recoverable: exiting now error generating backup Cannot load Zend OPcache - it was already loaded Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode disabled

NextCloudPi diagnostics ``` Cannot load Zend OPcache - it was already loaded NextCloudPi version v1.39.0 NextCloudPi image NextCloudPi_docker_01-19-21 distribution Debian GNU/Linux 10 \n \l automount no USB devices none datadir /data/nextcloud/data data in SD yes data filesystem overlayfs data disk usage 23G/48G rootfs usage 23G/48G swapfile /swap dbdir /data/database Nextcloud check ok Nextcloud version 20.0.4.0 HTTPD service up PHP service up MariaDB service up Redis service up Postfix service up internet check ok port check 80 closed port check 443 closed IP ***REMOVED SENSITIVE VALUE*** gateway ***REMOVED SENSITIVE VALUE*** interface eth0 certificates ***REMOVED SENSITIVE VALUE*** NAT loopback no uptime 11:05 ```
Nextcloud configuration ``` Cannot load Zend OPcache - it was already loaded Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade { "system": { "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": { "0": "localhost", "5": "nextcloudpi.local", "7": "nextcloudpi", "8": "nextcloudpi.lan", "1": "172.17.0.2", "6": "192.168.1.65", "3": "nextcloudpi" }, "datadirectory": "***REMOVED SENSITIVE VALUE***", "dbtype": "mysql", "version": "18.0.3.0", "overwrite.cli.url": "https:\/\/nextcloudpi\/", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "mysql.utf8mb4": true, "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "installed": true, "instanceid": "***REMOVED SENSITIVE VALUE***", "memcache.local": "\\OC\\Memcache\\Redis", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0, "password": "***REMOVED SENSITIVE VALUE***" }, "tempdirectory": "\/var\/www\/nextcloud\/data\/tmp", "mail_smtpmode": "sendmail", "mail_smtpauthtype": "LOGIN", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "preview_max_x": "2048", "preview_max_y": "2048", "jpeg_quality": "60", "overwriteprotocol": "https", "maintenance": false, "loglevel": 2, "trusted_proxies": "***REMOVED SENSITIVE VALUE***" } } ```
HTTPd logs ``` [Wed Sep 08 02:15:46.874358 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/ncp-logo.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.882244 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /wizard/img/ncp-logo.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.886971 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/toggle.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.889035 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/defaults.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.911974 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/poweroff.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.911974 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/reboot.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.935732 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/view-close.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.936091 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/search.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.936607 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/nc-button.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.938924 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/defaults-white.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.938909 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/dashboard.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.939036 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/settings-white.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.939204 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/wizard.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.939963 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/info-white.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.941196 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/files.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.949438 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.949941 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-output.php failed, reason: unable to get the remote host name [Wed Sep 08 02:15:47.003203 2021] [authz_host:error] [pid 28812:tid 281472595276176] [client 172.17.0.1:65320] AH01753: access check of 'localhost' to /img/favicon.png failed, reason: unable to get the remote host name [Wed Sep 08 02:15:51.744702 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name [Wed Sep 08 02:15:51.758102 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name ```
Database logs ``` 2021-09-08 6:36:41 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:42 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:43 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:44 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:45 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:46 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:47 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:48 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:49 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:49 0 [ERROR] InnoDB: Operating system error number 11 in a file operation. 2021-09-08 6:36:49 0 [ERROR] InnoDB: Error number 11 means 'Resource temporarily unavailable' 2021-09-08 6:36:49 0 [ERROR] InnoDB: Cannot open datafile './ibdata1' 2021-09-08 6:36:49 0 [ERROR] InnoDB: Could not open or create the system tablespace. If you tried to add new data files to the system tablespace, and it failed here, you should now edit innodb_data_file_path in my.cnf back to what it was, and remove the new ibdata files InnoDB created in this failed attempt. InnoDB only wrote those files full of zeros, but did not yet use them in any way. But be careful: do not remove old data files which contain your precious data! 2021-09-08 6:36:49 0 [ERROR] InnoDB: Plugin initialization aborted with error Cannot open a file 2021-09-08 6:36:50 0 [ERROR] Plugin 'InnoDB' init function returned error. 2021-09-08 6:36:50 0 [ERROR] Plugin 'InnoDB' registration as a STORAGE ENGINE failed. 2021-09-08 6:36:50 0 [ERROR] Unknown/unsupported storage engine: InnoDB 2021-09-08 6:36:50 0 [ERROR] Aborting Warning: Memory not freed: 520 ```
Nextcloud logs ``` {"reqId":"oZYOhg8z9ayeVQSoZwL7","level":2,"time":"2021-09-08T14:40:01+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"oZYOhg8z9ayeVQSoZwL7","level":2,"time":"2021-09-08T14:40:01+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"GUJsTvT8WpU6y02GccZe","level":2,"time":"2021-09-08T14:42:46+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"GUJsTvT8WpU6y02GccZe","level":2,"time":"2021-09-08T14:42:46+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"pD2bz91qBA6qRlJxD4X4","level":2,"time":"2021-09-08T14:42:46+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"pD2bz91qBA6qRlJxD4X4","level":2,"time":"2021-09-08T14:42:46+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"bXP47VIekKs8xk4wrpET","level":2,"time":"2021-09-08T14:43:19+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"bXP47VIekKs8xk4wrpET","level":2,"time":"2021-09-08T14:43:19+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"ctdJRV8O6xuEpSd2v552","level":2,"time":"2021-09-08T14:43:20+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"ctdJRV8O6xuEpSd2v552","level":2,"time":"2021-09-08T14:43:20+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"gcIhCGqyTxzPpFMYF0GI","level":2,"time":"2021-09-08T14:43:24+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"gcIhCGqyTxzPpFMYF0GI","level":2,"time":"2021-09-08T14:43:24+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"nKoJxP6zYQE8htEScgWW","level":2,"time":"2021-09-08T14:43:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"nKoJxP6zYQE8htEScgWW","level":2,"time":"2021-09-08T14:43:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"m7cudvmHOTnoUW0aOdLo","level":2,"time":"2021-09-08T14:43:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"m7cudvmHOTnoUW0aOdLo","level":2,"time":"2021-09-08T14:43:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"d304npqvqlErv5JPmY5W","level":2,"time":"2021-09-08T14:44:55+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"d304npqvqlErv5JPmY5W","level":2,"time":"2021-09-08T14:44:55+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"8oTw82MYH3T3MowzVAj6","level":2,"time":"2021-09-08T14:45:01+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"8oTw82MYH3T3MowzVAj6","level":2,"time":"2021-09-08T14:45:01+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} ```
nachoparker commented 3 years ago

thanks @WeiChihChern let's just run these commands

sudo sed -i  '1aset -x' /usr/local/bin/ncp-backup
sudo ncp-config
# start a backup from the menu

thanks

ovpc commented 3 years ago

@nachoparker

maybe it was a one time glitch

Must have been, it completed without issue this time terminal output @ https://pastebin.com/fCrED0ta

nachoparker commented 3 years ago

@ovpc oh gosh, that makes me a bit uneasy :/

but glad it worked for you

ovpc commented 3 years ago

It is complaining about

Module php-imagick in this instance has no SVG support. For better compatibility it is recommended to install it.

nachoparker commented 3 years ago

can you try this?

https://help.nextcloud.com/t/how-to-enable-svg-for-php-imagick/108646/5

ovpc commented 3 years ago

had already found same fix at https://techoverflow.net/2021/08/17/how-to-fix-docker-nextcloud-module-php-imagick-in-this-instance-has-no-svg-support-for-better-compatibility-it-is-recommended-to-install-it/

sudo apt install libmagickcore-6.q16-6-extra

fixed it

WeiChihChern commented 3 years ago

thanks @WeiChihChern let's just run these commands

sudo sed -i  '1aset -x' /usr/local/bin/ncp-backup
sudo ncp-config
# start a backup from the menu

thanks

What I got:

Running nc-update-nextcloud Cannot load Zend OPcache - it was already loaded Cannot load Zend OPcache - it was already loaded Cannot load Zend OPcache - it was already loaded Current Nextcloud version 20.0.4.0 Available Nextcloud version 21.0.4 Download Nextcloud 21.0.4... Back up current instance...

  • set -eE
  • destdir=/var/www/
  • includedata=no
  • compress=yes
  • backuplimit=0 ++ date +%Y%m%d_%s
  • destfile=/var/www//nextcloud-bkp_20210908_1631113525.tar ++ date +%Y%m%d
  • dbbackup=nextcloud-sqlbkp_20210908.bak
  • occ='sudo -u www-data php /var/www/nextcloud/occ'
  • [[ -f /.docker-image ]]
  • basedir=/data
  • [[ yes == \y\e\s ]]
  • destfile=/var/www//nextcloud-bkp_20210908_1631113525.tar.gz ++ sudo -u www-data php /var/www/nextcloud/occ config:system:get datadirectory Cannot load Zend OPcache - it was already loaded
  • datadir='Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade /data/nextcloud/data'
  • trap cleanup EXIT
  • trap fail INT TERM HUP ERR
  • echo 'check free space...' check free space...
  • mkdir -p /var/www/ ++ du -sb /data/nextcloud ++ awk '{ print $1 }'
  • nsize=408125092
  • [[ -d /data/nextcloud/data ]] ++ du -sb /data/nextcloud/data ++ awk '{ print $1 }'
  • dsize=61061140
  • margin=524288000
  • [[ no == \y\e\s ]]
  • size=871351952 ++ df -B1 /var/www/ ++ tail -1 ++ awk '{ print $4 }'
  • free=23708033024
  • '[' 871351952 -ge 23708033024 ']'
  • [[ 0 != 0 ]]
  • sudo -u www-data php /var/www/nextcloud/occ maintenance:mode --on Cannot load Zend OPcache - it was already loaded Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode enabled
  • cd /data
  • echo 'backup database...' backup database...
  • mysqldump -u root --single-transaction nextcloud
  • echo 'backup files...' backup files...
  • [[ no == \y\e\s ]]
  • [[ yes == \y\e\s ]]
  • compress_arg='-I pigz'
  • mkdir -p /var/www/ ++ dirname 'Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade /data/nextcloud/data/'
  • tar -I pigz -cf /var/www//nextcloud-bkp_20210908_1631113525.tar.gz nextcloud-sqlbkp20210908.bak --exclude /.opcache --exclude '/{access,error,nextcloud}.log' --exclude /access.log --exclude /ncp-update-backups -C 'Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade /data/nextcloud' --exclude 'nextcloud/data//files/' --exclude nextcloud/data/.opcache --exclude 'nextcloud/data/{access,error,nextcloud}.log' --exclude nextcloud/data/access.log --exclude 'nextcloud/data/appdata/preview/' --exclude 'nextcloud/data//uploads/' --exclude 'nextcloud/data//cache/' --exclude 'nextcloud/data//files_trashbin/' --exclude 'nextcloud/data//files_versions/' --exclude nextcloud/data/ncp-update-backups --exclude nextcloud/data/__groupfolders -C /data nextcloud/ tar: Nextcloud or one of the apps require upgrade - only a limited number of commands are available\nYou may use your browser or the occ upgrade command to do the upgrade\n/data/nextcloud: Cannot open: No such file or directory tar: Error is not recoverable: exiting now
  • echo 'error generating backup' error generating backup
  • exit 1
  • cleanup
  • local ret=1
  • rm -f nextcloud-sqlbkp_20210908.bak
  • sudo -u www-data php /var/www/nextcloud/occ maintenance:mode --off Cannot load Zend OPcache - it was already loaded Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade Maintenance mode disabled
  • exit 1 Error backing up Clean up... Done. Press any key...
Nextcloud configuration ``` Cannot load Zend OPcache - it was already loaded Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade { "system": { "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": { "0": "localhost", "5": "nextcloudpi.local", "7": "nextcloudpi", "8": "nextcloudpi.lan", "1": "172.17.0.2", "6": "192.168.1.65", "3": "nextcloudpi" }, "datadirectory": "***REMOVED SENSITIVE VALUE***", "dbtype": "mysql", "version": "18.0.3.0", "overwrite.cli.url": "https:\/\/nextcloudpi\/", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "mysql.utf8mb4": true, "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "installed": true, "instanceid": "***REMOVED SENSITIVE VALUE***", "memcache.local": "\\OC\\Memcache\\Redis", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0, "password": "***REMOVED SENSITIVE VALUE***" }, "tempdirectory": "\/var\/www\/nextcloud\/data\/tmp", "mail_smtpmode": "sendmail", "mail_smtpauthtype": "LOGIN", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "preview_max_x": "2048", "preview_max_y": "2048", "jpeg_quality": "60", "overwriteprotocol": "https", "maintenance": false, "loglevel": 2, "trusted_proxies": "***REMOVED SENSITIVE VALUE***" } } ```
HTTPd logs ``` [Wed Sep 08 02:15:46.874358 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/ncp-logo.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.882244 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /wizard/img/ncp-logo.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.886971 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/toggle.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.889035 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/defaults.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.911974 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/poweroff.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.911974 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/reboot.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.935732 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/view-close.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.936091 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/search.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.936607 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/nc-button.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.938924 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/defaults-white.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.938909 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/dashboard.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.939036 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/settings-white.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.939204 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/wizard.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.939963 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/info-white.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.941196 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /img/files.svg failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.949438 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name [Wed Sep 08 02:15:46.949941 2021] [authz_host:error] [pid 28812:tid 281472612061584] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-output.php failed, reason: unable to get the remote host name [Wed Sep 08 02:15:47.003203 2021] [authz_host:error] [pid 28812:tid 281472595276176] [client 172.17.0.1:65320] AH01753: access check of 'localhost' to /img/favicon.png failed, reason: unable to get the remote host name [Wed Sep 08 02:15:51.744702 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name [Wed Sep 08 02:15:51.758102 2021] [authz_host:error] [pid 28812:tid 281472620454288] [client 172.17.0.1:65316] AH01753: access check of 'localhost' to /ncp-launcher.php failed, reason: unable to get the remote host name ```
Database logs ``` 2021-09-08 6:36:41 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:42 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:43 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:44 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:45 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:46 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:47 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:48 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:49 0 [ERROR] InnoDB: Unable to lock ./ibdata1 error: 11 2021-09-08 6:36:49 0 [ERROR] InnoDB: Operating system error number 11 in a file operation. 2021-09-08 6:36:49 0 [ERROR] InnoDB: Error number 11 means 'Resource temporarily unavailable' 2021-09-08 6:36:49 0 [ERROR] InnoDB: Cannot open datafile './ibdata1' 2021-09-08 6:36:49 0 [ERROR] InnoDB: Could not open or create the system tablespace. If you tried to add new data files to the system tablespace, and it failed here, you should now edit innodb_data_file_path in my.cnf back to what it was, and remove the new ibdata files InnoDB created in this failed attempt. InnoDB only wrote those files full of zeros, but did not yet use them in any way. But be careful: do not remove old data files which contain your precious data! 2021-09-08 6:36:49 0 [ERROR] InnoDB: Plugin initialization aborted with error Cannot open a file 2021-09-08 6:36:50 0 [ERROR] Plugin 'InnoDB' init function returned error. 2021-09-08 6:36:50 0 [ERROR] Plugin 'InnoDB' registration as a STORAGE ENGINE failed. 2021-09-08 6:36:50 0 [ERROR] Unknown/unsupported storage engine: InnoDB 2021-09-08 6:36:50 0 [ERROR] Aborting Warning: Memory not freed: 520 ```
Nextcloud logs ``` {"reqId":"BAF92sotBmzUpIPuSOYr","level":2,"time":"2021-09-08T15:05:16+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"BAF92sotBmzUpIPuSOYr","level":2,"time":"2021-09-08T15:05:16+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"VHtSTyaf5Q3UGVYhQx5j","level":2,"time":"2021-09-08T15:05:17+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"VHtSTyaf5Q3UGVYhQx5j","level":2,"time":"2021-09-08T15:05:17+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"JGjQ6TY6TyX2xW0RfzYn","level":2,"time":"2021-09-08T15:05:17+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"JGjQ6TY6TyX2xW0RfzYn","level":2,"time":"2021-09-08T15:05:17+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"PA1MCvHfJUqfHPtsVy78","level":2,"time":"2021-09-08T15:05:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"PA1MCvHfJUqfHPtsVy78","level":2,"time":"2021-09-08T15:05:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"Qjwn1wLKLgBA81NGYieg","level":2,"time":"2021-09-08T15:05:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"Qjwn1wLKLgBA81NGYieg","level":2,"time":"2021-09-08T15:05:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"jHF1P66pk7nWOvd6lasK","level":2,"time":"2021-09-08T15:05:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"jHF1P66pk7nWOvd6lasK","level":2,"time":"2021-09-08T15:05:25+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"qqNrqrbMq9G2JUoRwpa9","level":2,"time":"2021-09-08T15:06:33+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"qqNrqrbMq9G2JUoRwpa9","level":2,"time":"2021-09-08T15:06:33+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"5nVmzs3CNhuSvDIydYMV","level":2,"time":"2021-09-08T15:06:33+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"5nVmzs3CNhuSvDIydYMV","level":2,"time":"2021-09-08T15:06:33+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"wwjYxU5xwPhzJSKhs0Ir","level":2,"time":"2021-09-08T15:06:40+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"wwjYxU5xwPhzJSKhs0Ir","level":2,"time":"2021-09-08T15:06:40+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"fE3nUl16Zb5wbQFZsRKt","level":2,"time":"2021-09-08T15:06:45+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} {"reqId":"fE3nUl16Zb5wbQFZsRKt","level":2,"time":"2021-09-08T15:06:45+00:00","remoteAddr":"","user":"--","app":"no app in context","method":"","url":"--","message":"Temporary directory /var/www/nextcloud/data/tmp is not present or writable","userAgent":"--","version":"18.0.3.0"} ```
nachoparker commented 3 years ago

@ovpc sweet, thanks, we are back to the imagick discussion though. Not sure if we should install it for security reasons

nachoparker commented 3 years ago

@WeiChihChern

ugh

++ sudo -u www-data php /var/www/nextcloud/occ config:system:get datadirectory
Cannot load Zend OPcache - it was already loaded
datadir='Nextcloud or one of the apps require upgrade - only a limited number of commands are available
You may use your browser or the occ upgrade command to do the upgrade

I see what's going on, we should handle this more gracefully. What is the output from

ncc config:system:get datadirectory 2> /dev/null
echo $?
WeiChihChern commented 3 years ago

@nachoparker

root@bbb3f069dfbb:/# ncc config:system:get datadirectory 2> /dev/null Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade /data/nextcloud/data root@bbb3f069dfbb:/# echo $? 0

nachoparker commented 3 years ago

@WeiChihChern

ncc status

?

WeiChihChern commented 3 years ago

@nachoparker

root@bbb3f069dfbb:/# ncc status Cannot load Zend OPcache - it was already loaded Nextcloud or one of the apps require upgrade - only a limited number of commands are available You may use your browser or the occ upgrade command to do the upgrade

  • installed: true
  • version: 20.0.4.0
  • versionstring: 20.0.4
  • edition: root@bbb3f069dfbb:/#
nachoparker commented 3 years ago

hmm I wonder why you keep getting that message, if you log into Nextcloud, does everything work on the web interface?

WeiChihChern commented 3 years ago

Opening the web interface

image

Clicked upgrade:

image
nachoparker commented 3 years ago

yes, your instance was in a weird half-upgraded state to start with. I would go to the NC forums if you want to try to fix that

vcbranco commented 3 years ago

@WeiChihChern that's not how it works, if you want to retain your users, data and so on you need to upgrade, no way around that.

Updated apps and nextcloud from 18.0.3 to 20.0.12 first.

How did you do this? through NC updater or through NCP tools? it seems like you were in a half updated state. I updated from 18 to 20 and then did ncp-update nc-21-vcbranco and then upgraded to 21 all using NCP tools and it worked fine for me.

@vcbranco thanks for your testing. You never shared the output from your second attempt with static IP so I don't know how it went. You just said it didn't work. Then you changed your setup and you shared the output, so we are mixing things here and I cannot trace whether my fix worked or needs adjustments.

I'm going to setup a test DNS to the upgrade

what does this mean? on your last output I see https://pi.emcontacto.eu in overwrite.cli.url, but I don't know where it comes from. notify_push seems to have a problem with it. Are you behind a proxy? have you messed with the 'forwarded_for_headers' option in your config.php by any chance?

This is the test with the fixes nc-static-ip and letsencrypt configured

https://github.com/nextcloud/nextcloudpi/issues/1326#issuecomment-914511671

Something you said and I did not understant/noticed?

vcbranco commented 3 years ago

I'm not behind a proxy and did not make any change in the config files. I installed the image on the pi, updated with ncp-update and ncp-update-nextcloud and sudo apt update/upgrade

WeiChihChern commented 3 years ago

yes, your instance was in a weird half-upgraded state to start with. I would go to the NC forums if you want to try to fix that

It's fine, this is only a test container. Looking forward to the final release.

nachoparker commented 3 years ago

@vcbranco thanks for clarifying, by the way, you don't have to and should not do sudo apt update/upgrade, let NCP do it automatically for you to make sure you don't override any configuration.

Can you run nc-static-IP again and then share the output of ncp-update-nc 21.0.4 so I can see why my fix failed?

After that I think we want to look into your letsencrypt attempt.

ncc notify_push:setup https://pi.emcontacto.eu/push
🗴 push server is not a trusted proxy, please add '10.8.6.1' to the list of trusted proxies or configure any existing reverse proxy to forward the 'x-forwarded-for' send by the push server.
See https://docs.nextcloud.com/server/latest/admin_manual/configuration_server/reverse_proxy_configuration.html#defining-trusted-proxies for how to set trusted proxies.
The following trusted proxies are currently configured: "127.0.0.1", "::1", "pi.emcontacto.eu"
of which the following seem to be invalid: "pi.emcontacto.eu"
The following x-forwarded-for header was received by Nextcloud: 1.2.3.4
from the following remote: 10.8.6.1

Thanks

vcbranco commented 3 years ago

Ok. I'll do that

nachoparker commented 3 years ago

@vcbranco I added another tweak for your "letsencrypt attempt". In order to test this one, please run

ncp-update nc-21-vcbranco # download the fix
ncp-config
# run letsencrypt again inside the menu
ncp-update-nc 21.0.4

thanks