UNSOLVED Absturz jede Nacht - ECONNRESET - ECONNREFUSED
-
Sorry, das war nur die Systeminfo. Ich schreibe hier meinen erstene Beitrag und habe nachdem IOBROKER seit 6 Monaten stabil lief nun das Problem, dass das System jede Nacht abstürzt und es morgens nicht mehr erreichrbar ist.
Im Log sind folgende Einträge:
2020-07-06 00:27:22.407 - info: javascript.0 (3818) script.js.common.Licht.Aussenbeleuchtung: 2 2020-07-06 00:27:29.896 - error: node-red.0 (10929) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:27:53.090 - info: javascript.0 (3818) script.js.common.Licht.Aussenbeleuchtung: 3 2020-07-06 00:28:07.679 - error: node-red.0 (10929) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:30.952 - error: kodi.0 (3609) read ECONNRESET 2020-07-06 00:28:47.793 - error: kodi.0 (3609) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.833 - error: javascript.0 (3818) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.814 - error: host.tinkerboard connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.787 - error: pushover.0 (3676) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.802 - error: backitup.0 (13399) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.798 - error: sql.0 (4698) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.782 - error: discovery.0 (2589) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.815 - error: lgtv.0 (3652) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.796 - error: yahka.0 (6729) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.795 - error: harmony.0 (13608) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.809 - error: snmp.0 (3719) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.800 - error: email.0 (2625) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.792 - error: node-red.0 (10248) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.804 - error: tr-064.0 (9698) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.797 - error: zwave2.0 (7473) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.788 - error: hm-rpc.2 (2994) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.810 - error: hm-rega.0 (2665) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.805 - error: sonoff.0 (4102) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.813 - error: hm-rpc.1 (2975) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.792 - error: web.0 (5926) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.817 - error: hm-rpc.0 (2914) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.799 - error: info.0 (3029) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.813 - error: cloud.0 (2550) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:47.818 - error: admin.0 (2309) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:48.255 - error: shelly.0 (3691) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:28:53.012 - info: javascript.0 (3818) script.js.common.Licht.Aussenbeleuchtung: 2 2020-07-06 00:29:00.241 - error: node-red.0 (10929) connect ECONNREFUSED 127.0.0.1:6379 2020-07-06 00:29:23.128 - info: javascript.0 (3818) script.js.common.Licht.Aussenbeleuchtung: 3 2020-07-06 00:29:24.455 - info: info.0 (3029) Popup news was read... 2020-07-06 00:29:34.155 - error: sonoff.0 (4102) read ECONNRESET 2020-07-06 00:29:35.559 - error: shelly.0 (3691) read ECONNRESET 2020-07-06 00:29:36.171 - error: node-red.0 (10929) connect ECONNREFUSED 127.0.0.1:6379 -
Es wäre toll wenn mir jemand weiterhlefen könnte. Ich bin mir unsicher ob das Problem durch eines der letzten Aktualisierung der Adapter bzw. Updates ausgelöst wurde. Ich versuche das System immer aktuell zu halten. Kann aber nicht nachvollziehen, ob es einen Zusammenhang gibt. Mein Netz läuft ansonsten stabil. Der IOBROKER ist über LAN verbunden.
-
Also nachdem was ich gegoogelt habe ist der Port 6379 mit dem Localhost der Redis-Server. Rufe ich den Redis-Server auf bekomme ich folgende Meldungen:
linaro@tinkerboard:~$ redis-server 15933:C 07 Jul 06:46:31.001 # Warning: no config file specified, using the defau lt config. In order to specify a config file use redis-server /path/to/redis.con f 15933:M 07 Jul 06:46:31.004 * Increased maximum number of open files to 10032 (i t was originally set to 1024). 15933:M 07 Jul 06:46:31.005 # Warning: 32 bit instance detected but no memory li mit set. Setting 3 GB maxmemory limit with 'noeviction' policy now. _._ _.-``__ ''-._ _.-`` `. `_. ''-._ Redis 3.2.6 (00000000/0) 32 bit .-`` .-```. ```\/ _.,_ ''-._ ( ' , .-` | `, ) Running in standalone mode |`-._`-...-` __...-.``-._|'` _.-'| Port: 6379 | `-._ `._ / _.-' | PID: 15933 `-._ `-._ `-./ _.-' _.-' |`-._`-._ `-.__.-' _.-'_.-'| | `-._`-._ _.-'_.-' | http://redis.io `-._ `-._`-.__.-'_.-' _.-' |`-._`-._ `-.__.-' _.-'_.-'| | `-._`-._ _.-'_.-' | `-._ `-._`-.__.-'_.-' _.-' `-._ `-.__.-' _.-' `-._ _.-' `-.__.-' 15933:M 07 Jul 06:46:31.007 # WARNING: The TCP backlog setting of 511 cannot be enforced because /proc/sys/net/core/somaxconn is set to the lower value of 128. 15933:M 07 Jul 06:46:31.007 # Server started, Redis version 3.2.6 15933:M 07 Jul 06:46:31.008 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_m emory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.ove rcommit_memory=1' for this to take effect. 15933:M 07 Jul 06:46:31.010 * The server is now ready to accept connections on port 6379 -
@besa sagte in Absturz jede Nacht - ECONNRESET - ECONNREFUSED:
15933:M 07 Jul 06:46:31.008 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_m emory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.ove rcommit_memory=1' for this to take effect.
Bei so vielen laufenden Adaptern: Wieviel Arbeitsspeicher ist denn noch frei. Gib mal 'top' in der Konsole ein und poste hier das Ergebnis.
-
top - 08:24:57 up 5 min, 2 users, load average: 0,24, 0,19, 0,09 Tasks: 183 total, 1 running, 182 sleeping, 0 stopped, 0 zombie %Cpu(s): 15,0 us, 3,9 sy, 0,0 ni, 81,1 id, 0,0 wa, 0,0 hi, 0,0 si, 0,0 st KiB Mem : 2060400 total, 1609648 free, 201248 used, 249504 buff/cache KiB Swap: 102396 total, 102396 free, 0 used. 1826856 avail Mem PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND 4100 iobroker 20 0 157192 69684 26412 S 54,7 3,4 0:01.68 node 1 root 20 0 26736 5136 3812 S 2,3 0,2 0:04.17 systemd 4057 linaro 20 0 7160 2840 2296 R 1,6 0,1 0:00.48 top 179 root 20 0 13904 4808 4340 S 1,3 0,2 0:01.24 systemd-jo+ 431 message+ 20 0 5536 3124 2464 S 1,0 0,2 0:00.88 dbus-daemon 623 root 20 0 4412 1772 1540 S 1,0 0,1 0:01.07 link_monit+ 913 root 20 0 194760 56052 41768 S 0,7 2,7 0:03.08 Xorg 4194 redis 20 0 0 0 0 D 0,7 0,0 0:00.02 run-parts 7 root 20 0 0 0 0 S 0,3 0,0 0:00.24 rcu_sched 24 root 20 0 0 0 0 S 0,3 0,0 0:00.06 kworker/3:0 97 root 20 0 0 0 0 S 0,3 0,0 0:00.23 kworker/u8+ 134 root 20 0 0 0 0 S 0,3 0,0 0:00.03 kworker/u8+ 486 root 20 0 23100 2236 1676 S 0,3 0,1 0:00.24 rsyslogd 622 root 20 0 3424 348 304 S 0,3 0,0 0:00.04 tail 2 root 20 0 0 0 0 S 0,0 0,0 0:00.01 kthreadd 3 root 20 0 0 0 0 S 0,0 0,0 0:00.03 ksoftirqd/0 5 root 0 -20 0 0 0 S 0,0 0,0 0:00.00 kworker/0:+ -
@besa Der wirft ja nur KiB aus, bei mir MiB:
Tasks: 64 total, 2 running, 62 sleeping, 0 stopped, 0 zombie %Cpu(s): 90.3 us, 0.0 sy, 0.0 ni, 9.7 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st MiB Mem : 4096.0 total, 983.8 free, 2744.1 used, 368.0 buff/cache MiB Swap: 2048.0 total, 2017.5 free, 30.5 used. 1351.9 avail Mem -
@besa Konsolenausgaben bitte in CodeTags setzen.
Dann das System ohne laufenden X-Server betreiben.
-
Datenträger verfügbar: 49.2 %, gesamte RAM-Nutzung: 987 MB / Frei: 62% = 1.241 MB [Host: tinkerboard - 20 Prozesse]
Ich habe deshalb ein MULTI-HOST System eingerichtet und ein Teil gestern ausgelagert. Das brachte aber auch keinen Erfolg. MIt über 62% freien Speicher glaube ich hier nicht an einen Speicherfehler. Aber es könnte natürlich sein, dass der Redis-Server in einen Overflow oder Speicherengpass kommt, daher erst nachts. Tagsüber habe ich bisher immer einen Neustart gehabt.
-
Mit X-Server meinst Du ohne Redis-Server, oder ?. Ja dann wird es sehr langsam.
-
@besa Nein, ich meine die graphische Oberfläche des Systems. Die läuft da unnötiger Weise mit und frisst Ressourcen.
uname -a who -r -
@Thomas-Braun
AH Danke. Sehe gerade dass Redis mir folgendes meldet:7908:M 07 Jul 08:48:04.146 # Background saving error 7908:M 07 Jul 08:48:10.062 * 100 changes in 300 seconds. Saving... 7908:M 07 Jul 08:48:10.063 * Background saving started by pid 19857 19857:C 07 Jul 08:48:10.063 # Failed opening the RDB file dump.rdb (in server root dir /etc/redis) for saving: Permission denied -
Das ständig mit einer neuen PID
-
@besa Alles krumm aufgesetzt, scheint mir.
Aber ohne Konsolenrückmeldung keine Hilfe möglich. Viel Spaß noch, ich bin dann raus.
-
@Thomas-Braun
Sorry
Hier die Rückmeldunglinaro@tinkerboard:/etc/redis$ uname -a Linux tinkerboard 4.4.132+ #1 SMP Wed Aug 21 19:15:55 CST 2019 armv7l GNU/Linux linaro@tinkerboard:/etc/redis$ who -r Runlevel 5 2020-07-07 08:19 linaro@tinkerboard:/etc/redis$ -
setze mal deine kopierten Zeilen von der Konsole in Code tags </> diese Symbol anklicken und dazwischen einfügen
dann ercheint in der Antwort diese Fensterhier steht dann dein Text -
linaro@tinkerboard:/etc/redis$ uname -a Linux tinkerboard 4.4.132+ #1 SMP Wed Aug 21 19:15:55 CST 2019 armv7l GNU/Linuxlinaro@tinkerboard:/etc/redis$ who -r Runlevel 5 2020-07-07 08:19 -
@besa
guck mal hier, da hat @Thomas-Braun mir mal erklärt, das der Runlevel 5 nicht gut für ein Server ist. Vielleicht solltest du den mal auf Level 3 ändern, weiß aber nicht ob die Befehle die gleichen sind.https://forum.iobroker.net/topic/33702/iobroker-startet-sporadisch-neu/20
da kann @Thomas-Braun dir bestimmt weiterhelfen
-
Gemäß der Anleitung von Thomas- Braun habe ich auf Runlevel 3 umgestellt
sudo whoami systemctl get-default sudo systemctl set-default multi-user.target systemctl get-defaultund dann
sudo rebootDann
linaro@tinkerboard:/opt/iobroker$ who -r Runlevel 3 2020-07-07 09:30Ergebnis: IOBROKER läuft nicht mehr.
-
dann den Redis Server manuell gestartet mit
redis-serverIOBROKER läuft wieder !!!!!!!!!
aber Redis gibt folgende Meldungen aus
6122:C 07 Jul 09:40:36.703 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf 6122:M 07 Jul 09:40:36.704 * Increased maximum number of open files to 10032 (it was originally set to 1024). 6122:M 07 Jul 09:40:36.705 # Warning: 32 bit instance detected but no memory limit set. Setting 3 GB maxmemory limit with 'noeviction' policy now. _._ _.-``__ ''-._ _.-`` `. `_. ''-._ Redis 3.2.6 (00000000/0) 32 bit .-`` .-```. ```\/ _.,_ ''-._ ( ' , .-` | `, ) Running in standalone mode |`-._`-...-` __...-.``-._|'` _.-'| Port: 6379 | `-._ `._ / _.-' | PID: 6122 `-._ `-._ `-./ _.-' _.-' |`-._`-._ `-.__.-' _.-'_.-'| | `-._`-._ _.-'_.-' | http://redis.io `-._ `-._`-.__.-'_.-' _.-' |`-._`-._ `-.__.-' _.-'_.-'| | `-._`-._ _.-'_.-' | `-._ `-._`-.__.-'_.-' _.-' `-._ `-.__.-' _.-' `-._ _.-' `-.__.-' 6122:M 07 Jul 09:40:36.706 # WARNING: The TCP backlog setting of 511 cannot be enforced because /proc/sys/net/core/somaxconn is set to the lower value of 128. 6122:M 07 Jul 09:40:36.706 # Server started, Redis version 3.2.6 6122:M 07 Jul 09:40:36.706 * The server is now ready to accept connections on port 6379 ^C6122:signal-handler (1594107715) Received SIGINT scheduling shutdown... 6122:M 07 Jul 09:41:55.917 # User requested shutdown... 6122:M 07 Jul 09:41:55.917 * Saving the final RDB snapshot before exiting. 6122:M 07 Jul 09:41:55.955 * DB saved on disk 6122:M 07 Jul 09:41:55.955 # Redis is now ready to exit, bye bye... -
@besa
und schmiert beim laden der Instanzen ab........
