NCP unreachable after blackout - Redis?

Hi,

We had a blackout this morning and NCP on Odroid HC2 doesn’t seem to take that too well. The nextcloud won’t start anymore. When I try to login I get this message:

Internal Server Error

The server encountered an internal error and was unable to complete your request.
Please contact the server administrator if this error reappears multiple times, please include the technical details below in your report.
More details can be found in the server log.

I can login via SSH and get the whole NC-config going but nc-update doesn’t work with this error:

ncp-config
Running nc-update
Downloading updates
Performing updates
Running nc-autoupdate-nc
automatic Nextcloud updates enabled
Cannot load Zend OPcache - it was already loaded
An unhandled exception has been thrown:
RedisException: Redis server went away in /var/www/nextcloud/lib/private/Memcach e/Redis.php:54
Stack trace:
#0 /var/www/nextcloud/lib/private/Memcache/Redis.php(54): Redis->get('ab2339d22c 5420a...')
#1 /var/www/nextcloud/lib/private/App/InfoParser.php(57): OC\Memcache\Redis->get ('/var/www/nextcl...')
#2 /var/www/nextcloud/lib/private/App/AppManager.php(380): OC\App\InfoParser->pa rse('/var/www/nextcl...')
#3 /var/www/nextcloud/lib/private/legacy/app.php(551): OC\App\AppManager->getApp Info('files', false, NULL)
#4 /var/www/nextcloud/lib/private/AppFramework/App.php(65): OC_App::getAppInfo(' files')
#5 /var/www/nextcloud/lib/private/legacy/app.php(236): OC\AppFramework\App::buil dAppNamespace('files')
#6 /var/www/nextcloud/lib/private/legacy/app.php(119): OC_App::registerAutoloadi ng('files', '/var/www/nextcl...')
#7 /var/www/nextcloud/lib/base.php(654): OC_App::loadApps(Array)
#8 /var/www/nextcloud/lib/base.php(1068): OC::init()
#9 /var/www/nextcloud/console.php(46): require_once('/var/www/nextcl...')
#10 /var/www/nextcloud/occ(11): require_once('/var/www/nextcl...')
#11 {main}Done. Press any key...

Running sudo systemctl status redis && sudo systemctl restart redis I get this output:

● redis-server.service - Advanced key-value store
Loaded: loaded (/lib/systemd/system/redis-server.service; enabled; vendor preset: enabled)
Active: failed (Result: exit-code) since Wed 2019-04-24 06:35:02 UTC; 14min ago
Docs: http://redis.io/documentation,
man:redis-server(1)
Process: 2739 ExecStart=/usr/bin/redis-server /etc/redis/redis.conf (code=exited, status=1/FAILURE)
Process: 2735 ExecStartPre=/bin/run-parts --verbose /etc/redis/redis-server.pre-up.d (code=exited, status=0/SUCCESS)

Apr 24 06:35:02 nextcloudpi systemd[1]: redis-server.service: Unit entered failed state.
Apr 24 06:35:02 nextcloudpi systemd[1]: redis-server.service: Failed with result 'exit-code'.
Apr 24 06:35:02 nextcloudpi systemd[1]: redis-server.service: Service hold-off time over, scheduling restart.
Apr 24 06:35:02 nextcloudpi systemd[1]: Stopped Advanced key-value store.
Apr 24 06:35:02 nextcloudpi systemd[1]: redis-server.service: Start request repeated too quickly.
Apr 24 06:35:02 nextcloudpi systemd[1]: Failed to start Advanced key-value store.
Apr 24 06:35:02 nextcloudpi systemd[1]: redis-server.service: Unit entered failed state.
Apr 24 06:35:02 nextcloudpi systemd[1]: redis-server.service: Failed with result 'exit-code'.

I’m not at all an expert in server-logs, I actually don’t understand the output. I’d appreciate any help!

check redis log and copy/paste here or via pastebin using:

sudo tail -20 /var/log/redis/redis-server.log

It might give clues to why redis is failing to start.

There is no log output. The file exists, but it’s empty.

Maybe it just got rotated, and a new one was created, old ones get renamed and compressed. List all redis log files with:

sudo ls -lhtr /var/log/redis/

and view compressed logs with:

sudo zcat /var/log/redis/redis-server.log.1.gz

Thank you for your help :slight_smile: The folder is empty though, no additional files. I decided to revive my backup instead and run everything from docker, wanted to do that for a while now and seems like the opportunity.

Same problem here, i logged in internal IP:4443 and shutdown the whole program. Then unplug the power from the PI for 10 seconds and plugged in again and the PI started up and restarted Nextcloud on the PC’s and everything works again. :smile:

  • Nice it works for me.
  • Oh no Why not me

0 voters

I have a similar problem… my NextcloudPlus has been running fine on my RPi 3 for well over a year. Every once in a while the router gets whacked and comes up with a new IP. I just go to no-ip.com and adjust my extrnal address and I’m back in business. This time however I did not know the router had glitched and ssh into my NCP… notice my version is way behind and thought good time to ncp-update… process “seemed” to choke on quite a few things. At the end I rebooted and still no NCP. THEN, I realized the router had been whacked… update no-ip but still no go.

Got into the admin portal at :4443 and saw Nextcloud check “Error” and Redis service “down” as well as dbdir “does not exist”. Not sure what to try to bring my system back.

===== here is my ncp-report output

NextCloudPi diagnostics

/usr/local/bin/ncp-diag: line 27: jq: command not found
grep: /etc/mysql/mariadb.conf.d/90-ncp.cnf: No such file or directory
Cannot load Zend OPcache - it was already loaded
NextCloudPi version  v0.66.4
NextCloudPi image    NextCloudPlus_04-21-18
distribution         Raspbian GNU/Linux 9 \n \l
automount            no
USB devices          sda 
datadir              /media/USBdrive/ncdata
data in SD           no
data filesystem      ext2/ext3
data disk usage      174G/916G
rootfs usage         2.3G/15G
swapfile             /var/swap
dbdir                 (doesn't exist)
Nextcloud check      error
HTTPD service        up
PHP service          up
MariaDB service      up
Redis service        down
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               3:31

Nextcloud configuration

Cannot load Zend OPcache - it was already loaded
An unhandled exception has been thrown:
RedisException: Redis server went away in /var/www/nextcloud/lib/private/Memcache/Redis.php:54
Stack trace:
#0 /var/www/nextcloud/lib/private/Memcache/Redis.php(54): Redis->get('a2b270f1d0b40ac...')
#1 /var/www/nextcloud/lib/private/App/InfoParser.php(57): OC\Memcache\Redis->get('/var/www/nextcl...')
#2 /var/www/nextcloud/lib/private/App/AppManager.php(380): OC\App\InfoParser->parse('/var/www/nextcl...')
#3 /var/www/nextcloud/lib/private/legacy/app.php(551): OC\App\AppManager->getAppInfo('files', false, NULL)
#4 /var/www/nextcloud/lib/private/AppFramework/App.php(65): OC_App::getAppInfo('files')
#5 /var/www/nextcloud/lib/private/legacy/app.php(236): OC\AppFramework\App::buildAppNamespace('files')
#6 /var/www/nextcloud/lib/private/legacy/app.php(119): OC_App::registerAutoloading('files', '/var/www/nextcl...')
#7 /var/www/nextcloud/lib/base.php(654): OC_App::loadApps(Array)
#8 /var/www/nextcloud/lib/base.php(1068): OC::init()
#9 /var/www/nextcloud/console.php(46): require_once('/var/www/nextcl...')
#10 /var/www/nextcloud/occ(11): require_once('/var/www/nextcl...')
#11 {main}
HTTPd logs

[Thu Jun 13 06:25:02.520333 2019] [ssl:warn] [pid 818:tid 1996397712] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name
[Thu Jun 13 06:25:03.000698 2019] [mpm_event:notice] [pid 818:tid 1996397712] AH00489: Apache/2.4.25 (Raspbian) OpenSSL/1.0.2r configured -- resuming normal operations
[Thu Jun 13 06:25:03.000801 2019] [core:notice] [pid 818:tid 1996397712] AH00094: Command line: '/usr/sbin/apache2'
[Thu Jun 13 14:55:01.896482 2019] [mpm_event:notice] [pid 818:tid 1996397712] AH00491: caught SIGTERM, shutting down
[Thu Jun 13 14:55:15.170501 2019] [ssl:warn] [pid 570:tid 1995676816] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name
[Thu Jun 13 14:55:16.044086 2019] [ssl:warn] [pid 813:tid 1995676816] AH01909: localhost:4443:0 server certificate does NOT include an ID which matches the server name
[Thu Jun 13 14:55:17.003596 2019] [mpm_event:notice] [pid 813:tid 1995676816] AH00489: Apache/2.4.25 (Raspbian) OpenSSL/1.0.2r configured -- resuming normal operations
[Thu Jun 13 14:55:17.003798 2019] [core:notice] [pid 813:tid 1995676816] AH00094: Command line: '/usr/sbin/apache2'
[Thu Jun 13 16:02:20.705545 2019] [proxy_fcgi:error] [pid 896:tid 1834259504] [client 192.168.1.221:49056] AH01071: Got error 'PHP message: PHP Notice:  Undefined index: app in /var/www/ncp-web/index.php on line 238\nPHP message: PHP Notice:  Undefined index: app in /var/www/ncp-web/index.php on line 244\n'

Database logs

2019-06-13 14:55:23 1996188464 [Note] InnoDB: innodb_empty_free_list_algorithm has been changed to legacy because of small buffer pool size. In order to use backoff, increase buffer pool at least up to 20MB.

2019-06-13 14:55:23 1996188464 [Note] InnoDB: Using mutexes to ref count buffer pool pages
2019-06-13 14:55:23 1996188464 [Note] InnoDB: The InnoDB memory heap is disabled
2019-06-13 14:55:23 1996188464 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
2019-06-13 14:55:23 1996188464 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
2019-06-13 14:55:23 1996188464 [Note] InnoDB: Compressed tables use zlib 1.2.8
2019-06-13 14:55:23 1996188464 [Note] InnoDB: Using Linux native AIO
2019-06-13 14:55:23 1996188464 [Note] InnoDB: Using generic crc32 instructions
2019-06-13 14:55:23 1996188464 [Note] InnoDB: Initializing buffer pool, size = 128.0M
2019-06-13 14:55:23 1996188464 [Note] InnoDB: Completed initialization of buffer pool
2019-06-13 14:55:23 1996188464 [Note] InnoDB: Highest supported file format is Barracuda.
2019-06-13 14:55:23 1996188464 [Note] InnoDB: 128 rollback segment(s) are active.
2019-06-13 14:55:23 1996188464 [Note] InnoDB: Waiting for purge to start
2019-06-13 14:55:23 1996188464 [Note] InnoDB:  Percona XtraDB (http://www.percona.com) 5.6.42-84.2 started; log sequence number 1889806229
2019-06-13 14:55:23 1996188464 [Note] Plugin 'FEEDBACK' is disabled.
2019-06-13 14:55:23 1384117056 [Note] InnoDB: Dumping buffer pool(s) not yet started
2019-06-13 14:55:23 1996188464 [Note] Server socket created on IP: '127.0.0.1'.
2019-06-13 14:55:23 1996188464 [Note] /usr/sbin/mysqld: ready for connections.
Version: '10.1.38-MariaDB-0+deb9u1'  socket: '/var/run/mysqld/mysqld.sock'  port: 3306  Raspbian 9.0

Nextcloud logs

{"reqId":"WWkzun8AAQEAAAN2MQgAAAAB","level":2,"time":"2017-07-14T21:12:26+00:00","remoteAddr":"24.148.232.14","user":"--","app":"core","method":"POST","url":"\/","message":"Trusted domain error. \"24.148.232.14\" tried to access using \"100.14.82.22\" as host.","userAgent":"Mozilla\/5.0 (Windows NT 10.0; WOW64; Trident\/7.0; rv:11.0) like Gecko","version":"12.0.0.29"}
{"reqId":"WWk0Mn8AAQEAAAN3YEIAAABA","level":2,"time":"2017-07-14T21:14:26+00:00","remoteAddr":"24.148.232.14","user":"--","app":"core","method":"POST","url":"\/","message":"Trusted domain error. \"24.148.232.14\" tried to access using \"100.14.82.22\" as host.","userAgent":"Mozilla\/5.0 (Windows NT 10.0; WOW64; Trident\/7.0; rv:11.0) like Gecko","version":"12.0.0.29"}
{"reqId":"WWk0q38AAQEAAAN3YEMAAABB","level":2,"time":"2017-07-14T21:16:27+00:00","remoteAddr":"24.148.232.14","user":"--","app":"core","method":"POST","url":"\/","message":"Trusted domain error. \"24.148.232.14\" tried to access using \"100.14.82.22\" as host.","userAgent":"Mozilla\/5.0 (Windows NT 10.0; WOW64; Trident\/7.0; rv:11.0) like Gecko","version":"12.0.0.29"}
{"reqId":"WWk6OX8AAQEAAAvLv20AAEMX","level":2,"time":"2017-07-14T21:40:10+00:00","remoteAddr":"192.168.1.17","user":"admin","app":"no app in context","method":"POST","url":"\/index.php\/avatar\/cropped","message":"Missing expected parameters in change user hook","userAgent":"Mozilla\/5.0 (X11; Ubuntu; Linux armv7l; rv:54.0) Gecko\/20100101 Firefox\/54.0","version":"12.0.0.29"}
{"reqId":"WWk6OX8AAQEAAAvLv20AAEMX","level":2,"time":"2017-07-14T21:40:11+00:00","remoteAddr":"192.168.1.17","user":"admin","app":"no app in context","method":"POST","url":"\/index.php\/avatar\/cropped","message":"Missing expected parameters in change user hook","userAgent":"Mozilla\/5.0 (X11; Ubuntu; Linux armv7l; rv:54.0) Gecko\/20100101 Firefox\/54.0","version":"12.0.0.29"}
{"reqId":"WWk7fH8AAQEAAAvKGCgAAAwT","level":4,"time":"2017-07-14T21:49:29+00:00","remoteAddr":"192.168.1.17","user":"admin","app":"webdav","method":"PUT","url":"\/remote.php\/webdav\/EC\/Films\/SH3.mpg","message":"Exception: {\"Message\":\"HTTP\\\/1.1 400 expected filesize 947126272 got 376762368\",\"Exception\":\"Sabre\\\\DAV\\\\Exception\\\\BadRequest\",\"Code\":0,\"Trace\":\"#0 \\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/lib\\\/Connector\\\/Sabre\\\/Directory.php(151): OCA\\\\DAV\\\\Connector\\\\Sabre\\\\File->put(Resource id #9)\\n#1 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(1095): OCA\\\\DAV\\\\Connector\\\\Sabre\\\\Directory->createFile('SH3.mpg', Resource id #9)\\n#2 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/CorePlugin.php(525): Sabre\\\\DAV\\\\Server->createFile('EC\\\/Films\\\/SH3.mp...', Resource id #9, NULL)\\n#3 [internal function]: Sabre\\\\DAV\\\\CorePlugin->httpPut(Object(Sabre\\\\HTTP\\\\Request), Object(Sabre\\\\HTTP\\\\Response))\\n#4 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/event\\\/lib\\\/EventEmitterTrait.php(105): call_user_func_array(Array, Array)\\n#5 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(479): Sabre\\\\Event\\\\EventEmitter->emit('method:PUT', Array)\\n#6 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(254): Sabre\\\\DAV\\\\Server->invokeMethod(Object(Sabre\\\\HTTP\\\\Request), Object(Sabre\\\\HTTP\\\\Response))\\n#7 \\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/appinfo\\\/v1\\\/webdav.php(71): Sabre\\\\DAV\\\\Server->exec()\\n#8 \\\/var\\\/www\\\/nextcloud\\\/remote.php(162): require_once('\\\/var\\\/www\\\/nextcl...')\\n#9 {main}\",\"File\":\"\\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/lib\\\/Connector\\\/Sabre\\\/File.php\",\"Line\":151,\"User\":\"admin\"}","userAgent":"Mozilla\/5.0 (X11; Ubuntu; Linux armv7l; rv:54.0) Gecko\/20100101 Firefox\/54.0","version":"12.0.0.29"}
{"reqId":"WWk85H8AAQEAAAvKGDgAAAwG","level":4,"time":"2017-07-14T21:55:32+00:00","remoteAddr":"192.168.1.17","user":"admin","app":"webdav","method":"PUT","url":"\/remote.php\/webdav\/EC\/Films\/SH3.mpg","message":"Exception: {\"Message\":\"HTTP\\\/1.1 400 expected filesize 947126272 got 376721408\",\"Exception\":\"Sabre\\\\DAV\\\\Exception\\\\BadRequest\",\"Code\":0,\"Trace\":\"#0 \\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/lib\\\/Connector\\\/Sabre\\\/Directory.php(151): OCA\\\\DAV\\\\Connector\\\\Sabre\\\\File->put(Resource id #9)\\n#1 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(1095): OCA\\\\DAV\\\\Connector\\\\Sabre\\\\Directory->createFile('SH3.mpg', Resource id #9)\\n#2 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/CorePlugin.php(525): Sabre\\\\DAV\\\\Server->createFile('EC\\\/Films\\\/SH3.mp...', Resource id #9, NULL)\\n#3 [internal function]: Sabre\\\\DAV\\\\CorePlugin->httpPut(Object(Sabre\\\\HTTP\\\\Request), Object(Sabre\\\\HTTP\\\\Response))\\n#4 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/event\\\/lib\\\/EventEmitterTrait.php(105): call_user_func_array(Array, Array)\\n#5 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(479): Sabre\\\\Event\\\\EventEmitter->emit('method:PUT', Array)\\n#6 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(254): Sabre\\\\DAV\\\\Server->invokeMethod(Object(Sabre\\\\HTTP\\\\Request), Object(Sabre\\\\HTTP\\\\Response))\\n#7 \\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/appinfo\\\/v1\\\/webdav.php(71): Sabre\\\\DAV\\\\Server->exec()\\n#8 \\\/var\\\/www\\\/nextcloud\\\/remote.php(162): require_once('\\\/var\\\/www\\\/nextcl...')\\n#9 {main}\",\"File\":\"\\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/lib\\\/Connector\\\/Sabre\\\/File.php\",\"Line\":151,\"User\":\"admin\"}","userAgent":"Mozilla\/5.0 (X11; Ubuntu; Linux armv7l; rv:54.0) Gecko\/20100101 Firefox\/54.0","version":"12.0.0.29"}
{"reqId":"WWk@zX8AAQEAAAvKGIUAAAwL","level":4,"time":"2017-07-14T22:00:16+00:00","remoteAddr":"192.168.1.17","user":"admin","app":"webdav","method":"PUT","url":"\/remote.php\/webdav\/EC\/Films\/SH2.mpg","message":"Exception: {\"Message\":\"HTTP\\\/1.1 400 expected filesize 1216389120 got 57368576\",\"Exception\":\"Sabre\\\\DAV\\\\Exception\\\\BadRequest\",\"Code\":0,\"Trace\":\"#0 \\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/lib\\\/Connector\\\/Sabre\\\/Directory.php(151): OCA\\\\DAV\\\\Connector\\\\Sabre\\\\File->put(Resource id #9)\\n#1 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(1095): OCA\\\\DAV\\\\Connector\\\\Sabre\\\\Directory->createFile('SH2.mpg', Resource id #9)\\n#2 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/CorePlugin.php(525): Sabre\\\\DAV\\\\Server->createFile('EC\\\/Films\\\/SH2.mp...', Resource id #9, NULL)\\n#3 [internal function]: Sabre\\\\DAV\\\\CorePlugin->httpPut(Object(Sabre\\\\HTTP\\\\Request), Object(Sabre\\\\HTTP\\\\Response))\\n#4 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/event\\\/lib\\\/EventEmitterTrait.php(105): call_user_func_array(Array, Array)\\n#5 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(479): Sabre\\\\Event\\\\EventEmitter->emit('method:PUT', Array)\\n#6 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(254): Sabre\\\\DAV\\\\Server->invokeMethod(Object(Sabre\\\\HTTP\\\\Request), Object(Sabre\\\\HTTP\\\\Response))\\n#7 \\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/appinfo\\\/v1\\\/webdav.php(71): Sabre\\\\DAV\\\\Server->exec()\\n#8 \\\/var\\\/www\\\/nextcloud\\\/remote.php(162): require_once('\\\/var\\\/www\\\/nextcl...')\\n#9 {main}\",\"File\":\"\\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/lib\\\/Connector\\\/Sabre\\\/File.php\",\"Line\":151,\"User\":\"admin\"}","userAgent":"Mozilla\/5.0 (X11; Ubuntu; Linux armv7l; rv:54.0) Gecko\/20100101 Firefox\/54.0","version":"12.0.0.29"}
{"reqId":"WWk-PH8AAQEAAAvKGKIAAAwR","level":4,"time":"2017-07-14T22:05:20+00:00","remoteAddr":"192.168.1.17","user":"admin","app":"webdav","method":"PUT","url":"\/remote.php\/webdav\/EC\/Films\/SH1\/SH1.mpg","message":"Exception: {\"Message\":\"HTTP\\\/1.1 400 expected filesize 417187840 got 376135680\",\"Exception\":\"Sabre\\\\DAV\\\\Exception\\\\BadRequest\",\"Code\":0,\"Trace\":\"#0 \\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/lib\\\/Connector\\\/Sabre\\\/Directory.php(151): OCA\\\\DAV\\\\Connector\\\\Sabre\\\\File->put(Resource id #9)\\n#1 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(1095): OCA\\\\DAV\\\\Connector\\\\Sabre\\\\Directory->createFile('SH1.mpg', Resource id #9)\\n#2 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/CorePlugin.php(525): Sabre\\\\DAV\\\\Server->createFile('EC\\\/Films\\\/SH1\\\/SH...', Resource id #9, NULL)\\n#3 [internal function]: Sabre\\\\DAV\\\\CorePlugin->httpPut(Object(Sabre\\\\HTTP\\\\Request), Object(Sabre\\\\HTTP\\\\Response))\\n#4 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/event\\\/lib\\\/EventEmitterTrait.php(105): call_user_func_array(Array, Array)\\n#5 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(479): Sabre\\\\Event\\\\EventEmitter->emit('method:PUT', Array)\\n#6 \\\/var\\\/www\\\/nextcloud\\\/3rdparty\\\/sabre\\\/dav\\\/lib\\\/DAV\\\/Server.php(254): Sabre\\\\DAV\\\\Server->invokeMethod(Object(Sabre\\\\HTTP\\\\Request), Object(Sabre\\\\HTTP\\\\Response))\\n#7 \\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/appinfo\\\/v1\\\/webdav.php(71): Sabre\\\\DAV\\\\Server->exec()\\n#8 \\\/var\\\/www\\\/nextcloud\\\/remote.php(162): require_once('\\\/var\\\/www\\\/nextcl...')\\n#9 {main}\",\"File\":\"\\\/var\\\/www\\\/nextcloud\\\/apps\\\/dav\\\/lib\\\/Connector\\\/Sabre\\\/File.php\",\"Line\":151,\"User\":\"admin\"}","userAgent":"Mozilla\/5.0 (X11; Ubuntu; Linux armv7l; rv:54.0) Gecko\/20100101 Firefox\/54.0","version":"12.0.0.29"}
{"reqId":"WWlF4X8AAQEAACGoH5oAAAAQ","level":2,"time":"2017-07-14T22:29:53+00:00","remoteAddr":"66.87.81.78","user":"--","app":"core","method":"REPORT","url":"\/remote.php\/dav\/addressbooks\/users\/admin\/Personal\/","message":"Trusted domain error. \"66.87.81.78\" tried to access using \"ecnextcloud.ddns.net\" as host.","userAgent":"iOS\/9.3.2 (13F69) dataaccessd\/1.0","version":"12.0.0.29"}
{"reqId":"WWlF4n8AAQEAACGoH5sAAAAS","level":2,"time":"2017-07-14T22:29:54+00:00","remoteAddr":"66.87.81.78","user":"--","app":"core","method":"PROPFIND","url":"\/remote.php\/dav\/principals\/users\/admin\/","message":"Trusted domain error. \"66.87.81.78\" tried to access using \"ecnextcloud.ddns.net\" as host.","userAgent":"iOS\/9.3.2 (13F69) dataaccessd\/1.0","version":"12.0.0.29"}
{"reqId":"WWlF8X8AAQEAACGoH50AAAAT","level":2,"time":"2017-07-14T22:30:09+00:00","remoteAddr":"66.87.81.78","user":"--","app":"core","method":"PROPFIND","url":"\/remote.php\/dav\/calendars\/admin\/","message":"Trusted domain error. \"66.87.81.78\" tried to access using \"ecnextcloud.ddns.net\" as host.","userAgent":"iOS\/9.3.2 (13F69) dataaccessd\/1.0","version":"12.0.0.29"}
{"reqId":"WWlHWH8AAQEAACGoH6QAAAAQ","level":2,"time":"2017-07-14T22:36:08+00:00","remoteAddr":"192.168.1.17","user":"--","app":"core","method":"POST","url":"\/index.php\/login","message":"Login failed: 'admin' (Remote IP: '192.168.1.17')","userAgent":"Mozilla\/5.0 (X11; Ubuntu; Linux armv7l; rv:54.0) Gecko\/20100101 Firefox\/54.0","version":"12.0.0.29"}
{"reqId":"WWlnkcCoAZcAAAOWd3gAAABA","level":2,"time":"2017-07-15T00:53:38+00:00","remoteAddr":"66.87.81.78","user":"--","app":"core","method":"PROPFIND","url":"\/remote.php\/dav\/calendars\/admin\/","message":"Trusted domain error. \"66.87.81.78\" tried to access using \"ecnextcloud.ddns.net\" as host.","userAgent":"iOS\/9.3.2 (13F69) dataaccessd\/1.0","version":"12.0.0.29"}
{"reqId":"WWlrpsCoAZcAAAOVs4wAAAAG","level":2,"time":"2017-07-15T01:11:03+00:00","remoteAddr":"66.87.81.78","user":"--","app":"core","method":"OPTIONS","url":"\/remote.php\/dav\/principals\/users\/admin\/","message":"Trusted domain error. \"66.87.81.78\" tried to access using \"ecnextcloud.ddns.net\" as host.","userAgent":"iOS\/9.3.2 (13F69) dataaccessd\/1.0","version":"12.0.0.29"}
{"reqId":"WWlrp8CoAZcAAAOVs40AAAAH","level":2,"time":"2017-07-15T01:11:03+00:00","remoteAddr":"66.87.81.78","user":"--","app":"core","method":"PROPFIND","url":"\/remote.php\/dav\/principals\/users\/admin\/","message":"Trusted domain error. \"66.87.81.78\" tried to access using \"ecnextcloud.ddns.net\" as host.","userAgent":"iOS\/9.3.2 (13F69) dataaccessd\/1.0","version":"12.0.0.29"}
{"reqId":"WWnEjsCoAZcAAAOVs44AAAAI","level":2,"time":"2017-07-15T07:30:22+00:00","remoteAddr":"169.229.3.91","user":"--","app":"core","method":"GET","url":"\/","message":"Trusted domain error. \"169.229.3.91\" tried to access using \"100.14.82.22\" as host.","userAgent":"Mozilla\/5.0 zgrab\/0.x","version":"12.0.0.29"}
{"reqId":"WWnLTsCoAZcAAAOVs48AAAAJ","level":2,"time":"2017-07-15T07:59:10+00:00","remoteAddr":"184.105.247.252","user":"--","app":"core","method":"GET","url":"\/","message":"Trusted domain error. \"184.105.247.252\" tried to access using \"100.14.82.22\" as host.","userAgent":"--","version":"12.0.0.29"}
{"reqId":"WWoRNsCoAZcAAAOWd3sAAEYY","level":2,"time":"2017-07-15T12:57:26+00:00","remoteAddr":"137.226.113.21","user":"--","app":"core","method":"GET","url":"\/","message":"Trusted domain error. \"137.226.113.21\" tried to access using \"100.14.82.22\" as host.","userAgent":"Mozilla\/5.0 (X11; Ubuntu; Linux x86_64; rv:50.0) Gecko\/20100101 Firefox\/50.0","version":"12.0.0.29"}
{"reqId":"WWoRN8CoAZcAAAOWd4MAAEYG","level":2,"time":"2017-07-15T12:57:27+00:00","remoteAddr":"137.226.113.21","user":"--","app":"core","method":"GET","url":"\/index.php\/js\/core\/merged-template-prepend.js?v=fbc9c8ac349f665c24b153acfccad9cf-0","message":"Trusted domain error. \"137.226.113.21\" tried to access using \"100.14.82.22\" as host.","userAgent":"Mozilla\/5.0 (X11; Ubuntu; Linux x86_64; rv:50.0) Gecko\/20100101 Firefox\/50.0","version":"12.0.0.29"}

Just checked redis service and got the following… appears that can’t start advanced key-value store…

redis-server.service - Advanced key-value store
Loaded: loaded (/lib/systemd/system/redis-server.service; enabled; vendor preset: enabled)
Active: failed (Result: exit-code) since Thu 2019-06-13 18:40:13 UTC; 1h 43min ago
Docs: http://redis.io/documentation,
man:redis-server(1)
Process: 1259 ExecStopPost=/bin/run-parts --verbose /etc/redis/redis-server.post-down.d (code=exited, status=0/SUCCESS)
Process: 1256 ExecStop=/bin/kill -s TERM $MAINPID (code=exited, status=0/SUCCESS)
Process: 1253 ExecStop=/bin/run-parts --verbose /etc/redis/redis-server.pre-down.d (code=exited, status=0/SUCCESS)
Process: 640 ExecStartPost=/bin/run-parts --verbose /etc/redis/redis-server.post-up.d (code=exited, status=0/SUCCESS)
Process: 4556 ExecStart=/usr/bin/redis-server /etc/redis/redis.conf (code=exited, status=1/FAILURE)
Process: 4552 ExecStartPre=/bin/run-parts --verbose /etc/redis/redis-server.pre-up.d (code=exited, status=0/SUCCESS)
Main PID: 637 (code=exited, status=0/SUCCESS)

Jun 13 18:40:13 nextcloudplus systemd[1]: Failed to start Advanced key-value store.
Jun 13 18:40:13 nextcloudplus systemd[1]: redis-server.service: Unit entered failed state.
Jun 13 18:40:13 nextcloudplus systemd[1]: redis-server.service: Failed with result ‘exit-code’.
Jun 13 18:40:13 nextcloudplus systemd[1]: redis-server.service: Service hold-off time over, scheduling restart.
Jun 13 18:40:13 nextcloudplus systemd[1]: Stopped Advanced key-value store.
Jun 13 18:40:13 nextcloudplus systemd[1]: redis-server.service: Start request repeated too quickly.
Jun 13 18:40:13 nextcloudplus systemd[1]: Failed to start Advanced key-value store.
Jun 13 18:40:13 nextcloudplus systemd[1]: redis-server.service: Unit entered failed state.
Jun 13 18:40:13 nextcloudplus systemd[1]: redis-server.service: Failed with result ‘exit-code’.

Update…

Found some threads talking about a misspelling in a redis config setting changing the case of T from ‘RunTimeDirectory’ => ‘RuntimeDirectory’… but where?

Was able to launch redis manually (default config?) and came up fine. Shutdown cleanly and then rebooted NCP… now redis is up (but is it using the right config?).

NCP was still down… DB connection issues… USBdrive was not automounted… went in manually and mounted USBdrive… now NCP comes up and seems to function even though log is showing a bunch of missing config files;

root@nextcloudplus:/var/log# tail -20 ncp.log

sed: can’t read /etc/php/7.2/fpm/pool.d/www.conf: No such file or directory
grep: /etc/mysql/mariadb.conf.d/91-ncp.cnf: No such file or directory
Using 388893900 memory for the database
sed: can’t read /etc/mysql/mariadb.conf.d/91-ncp.cnf: No such file or directory

[ nc-limits ]
grep: /etc/php/7.2/fpm/conf.d/90-ncp.ini: No such file or directory
grep: /etc/php/7.2/fpm/conf.d/90-ncp.ini: No such file or directory
Using 729176064B for PHP
sed: can’t read /etc/php/7.2/fpm/conf.d/90-ncp.ini: No such file or directory
sed: can’t read /etc/php/7.2/fpm/conf.d/90-ncp.ini: No such file or directory
sed: can’t read /etc/php/7.2/fpm/conf.d/90-ncp.ini: No such file or directory
grep: /etc/php/7.2/fpm/pool.d/www.conf: No such file or directory
Using 4 PHP threads
sed: can’t read /etc/php/7.2/fpm/pool.d/www.conf: No such file or directory
sed: can’t read /etc/php/7.2/fpm/pool.d/www.conf: No such file or directory
grep: /etc/mysql/mariadb.conf.d/91-ncp.cnf: No such file or directory
Using 388893900 memory for the database
sed: can’t read /etc/mysql/mariadb.conf.d/91-ncp.cnf: No such file or directory

… looked for /etc/mysql/mariadb.conf.d/91-ncp.cnf… NADA … just showed set of 50 stuff but no 90 stuff
root@nextcloudplus:/etc/mysql/mariadb.conf.d# ls -l
total 16
-rw-r–r-- 1 root root 677 Jun 7 2017 50-client.cnf
-rw-r–r-- 1 root root 336 Jun 7 2017 50-mysql-clients.cnf
-rw-r–r-- 1 root root 1032 Jun 7 2017 50-mysqld_safe.cnf
-rw-r–r-- 1 root root 3795 Apr 20 2018 50-server.cnf

– looked for /etc/php/7.2/fpm/pool.d/www.conf… there is no fpm at 7.2
root@nextcloudplus:/etc/php/7.2# ls -l
total 4

– feels like the failed update changed some items but but not all

Was hoping to be able to do a backup with data and then try to get the upgrade from v0.66.4 -> v1.13.1
– last complete backup I have is 04/24/2018… same with ncp-config

Which raises another question… thought unattended upgrades was enabled back in my “NCPlus-config-restore” from 4/24…

Activating unattended-upgrades
[ unattended-upgrades ]
Unattended upgrades active: yes (autoreboot yes)
Unattended upgrades active: yes (autoreboot yes)

… most days I would have a notice that Unattended Upgrades had run… had no idea my NCP had fallen that far behind.

Back in the 4/28/2018 period all seemed to be working well including the Admin portal which is how I did the backups and burnt your new image and then restored.
Now my admin portal shows a mix of German and English and all the items I’ve tried just give me a red dot and fail to execute.

Continuing to dig in…

Further update…

Decided to try to push thru the ncp-update… it appeared to run this time now that redis was working and the USBDrive was mounted… see below;

pi@nextcloudplus:~ $ sudo ncp-update
Downloading updates
Performing updates
Cannot load Zend OPcache - it was already loaded
Config value squareSizes for app previewgenerator set to 32
Cannot load Zend OPcache - it was already loaded
Config value widthSizes for app previewgenerator set to 128 256 512
Cannot load Zend OPcache - it was already loaded
Config value heightSizes for app previewgenerator set to 128 256
Cannot load Zend OPcache - it was already loaded
System config value jpeg_quality set to string 60
Running unattended-upgrades
Unattended upgrades active: yes (autoreboot true)
–2019-06-17 19:01:37-- https://packages.sury.org/php/apt.gpg
Resolving packages.sury.org (packages.sury.org)… 104.31.94.169, 104.31.95.169, 2606:4700:30::681f:5fa9, …
Connecting to packages.sury.org (packages.sury.org)|104.31.94.169|:443… connected.
HTTP request sent, awaiting response… 200 OK
Length: 1769 (1.7K) [application/octet-stream]
Saving to: ‘/etc/apt/trusted.gpg.d/php.gpg’

/etc/apt/trusted.gpg.d/php 100%[=======================================>] 1.73K --.-KB/s in 0s

2019-06-17 19:01:37 (6.46 MB/s) - ‘/etc/apt/trusted.gpg.d/php.gpg’ saved [1769/1769]

Running nc-notify-updates
update web notifications enabled
Installing nc-backup
Hit:1 http://archive.raspberrypi.org/debian stretch InRelease
Get:2 http://raspbian.raspberrypi.org/raspbian stretch InRelease [15.0 kB]
Hit:3 https://packages.sury.org/php stretch InRelease
Fetched 15.0 kB in 1s (9,632 B/s)
Reading package lists… Done
Reading package lists… Done
Building dependency tree
Reading state information… Done
pigz is already the newest version (2.3.4-1).
0 upgraded, 0 newly installed, 0 to remove and 43 not upgraded.
Installing nc-restore
Hit:1 http://archive.raspberrypi.org/debian stretch InRelease
Hit:2 http://raspbian.raspberrypi.org/raspbian stretch InRelease
Hit:3 https://packages.sury.org/php stretch InRelease
Reading package lists… Done
Reading package lists… Done
Building dependency tree
Reading state information… Done
file is already the newest version (1:5.30-1+deb9u2).
file set to manually installed.
0 upgraded, 0 newly installed, 0 to remove and 43 not upgraded.
ls: cannot access ‘/etc/php/7.2/fpm/conf.d/-opcache.ini’: No such file or directory
ls: cannot access '/etc/php/7.2/cli/conf.d/
-opcache.ini’: No such file or directory
NextCloudPi updated to version v1.13.1

Looks like the update succeeded this time… only remaining issue is automount still not working… manual mount and went into admin portal… still in German but tried to reset automount to yes… this time a green dot! -) even thought no output appeared in the window. Only way to be sure is to reboot. Sure enough it is now active :wink:

So… went for broke and tried to do a full backup… this time took a while but output started appearing in the window… missing config files such as …

sed: can’t read /etc/php/7.2/fpm/conf.d/90-ncp.ini: No such file or directory

BUT… looks to be pushing forward with backup… will see how it goes

your image is terribly outdated. Sadly the best option right now is to restore a backup on the latest image.

We are improving the update process to work better with very outdated images.

Backup did complete… have both ncp-config and complete nextcloud-bkp. Got admin portal to automount and things "seemed " to be working. But today there were more issues… like you said think dir structure for config files etc is too far out of date?

Here is nc-provisioning output;
pi@nextcloudplus:/media/USBdrive/ncp-backups $ systemctl status nc-provisioning
● nc-provisioning.service - Randomize passwords on first boot
Loaded: loaded (/usr/lib/systemd/system/nc-provisioning.service; enabled; vendor preset: enabled)
Active: active (running) since Tue 2019-06-18 22:07:58 UTC; 16s ago
Main PID: 3281 (bash)
CGroup: /system.slice/nc-provisioning.service
├─3281 /bin/bash /usr/local/bin/ncp-provisioning.sh
├─3317 /bin/bash /usr/local/bin/ncp-provisioning.sh
├─3318 tee -a /var/log/ncp.log
└─3342 systemctl restart mysql.service

Jun 18 22:07:59 nextcloudplus bash[3281]: sed: can’t read /etc/php/7.2/fpm/conf.d/90-ncp.ini: No such file or directory
Jun 18 22:07:59 nextcloudplus bash[3281]: sed: can’t read /etc/php/7.2/fpm/conf.d/90-ncp.ini: No such file or directory
Jun 18 22:07:59 nextcloudplus bash[3281]: grep: /etc/php/7.2/fpm/pool.d/www.conf: No such file or directory
Jun 18 22:07:59 nextcloudplus bash[3281]: Using 4 PHP threads
Jun 18 22:07:59 nextcloudplus bash[3281]: sed: can’t read /etc/php/7.2/fpm/pool.d/www.conf: No such file or directory
Jun 18 22:07:59 nextcloudplus bash[3281]: sed: can’t read /etc/php/7.2/fpm/pool.d/www.conf: No such file or directory
Jun 18 22:07:59 nextcloudplus bash[3281]: grep: /etc/mysql/mariadb.conf.d/91-ncp.cnf: No such file or directory
Jun 18 22:07:59 nextcloudplus bash[3281]: Using 388425318 memory for the database
Jun 18 22:07:59 nextcloudplus bash[3281]: sed: can’t read /etc/mysql/mariadb.conf.d/91-ncp.cnf: No such file or directory
Jun 18 22:07:59 nextcloudplus bash[3281]: Warning: mysql.service changed on disk. Run ‘systemctl daemon-reload’ to reload units.

Am ready to do new image and restore… just want to avoid restoring whacked config… is there a dataonly restore? Has been years since a restore and can’t get into Admin portal to see…

Also thinking might be good opportunity to upgrade platform? Am still on the original Nextcloud Box that cam with the Western Digital drive built in… If not too problematic would like to consider the USB3 on the Rock64 you hilighted on your home page… or should I just stick with the RPi 3 to get up and running?

Well, I recommend almost anything over a pi.

Backup and restore will be safe. Your NC instance will be fine, only will have to go through the NCP wizard again (and any ncp-web configs).

Thanks for feedaback. Will reimage my RPi 3 and restore it for personal purposes. Then order Rock64 and use it for my clean energy business… compare and contrast :wink: Thanks for all you do.

1 Like

Bugger… just order Rock64 and bunch of RPi 3 stuff and saw surprise release of RPi 4B that has more RAM, USB3, Gigabit Ethernet with separate controllers for USB and Ethernet and can deliver dual HDMI output!

Reordered mine and will be looking forward to trying NCP on that?
Sad rumor was that Google had stepped in financially and we all know where that may lead :wink:

the rock 64 also has gigabit and USB3, I would still choose it over the rpi4