Hey Leute ich hab seit etwa einem Jahr das Problem, dass sich mein Raspi alle paar Wochen von selbst runterfährt. Ich bekomme noch per iobroker die Nachricht per Telegram "shutdown" und dann muss ich das Stromkabel kurz trennen um Ihn wieder zum laufen zu bringen. Ich kann nicht erkennen ob es ein Absturz ist oder irgendwo ein Befehl gesendet wird. Ich habe gedacht ich kann das Problem umgehen indem ich den Raspi einmal die Woche restarten lasse per Cronjob aber das hat leider nicht geholfen. Nun würde ich gerne wissen wie bekomme ich das raus? Es laufen mehrere Sachen auf dem Raspi: Homebridge, iobroker, Grafana, inFluxDB, Unifi Server, Deconz und MQTT. Mein Wissen reicht leider nicht aus um festzustellen woran es liegt. Das ganze passiert alle 4-8 Wochen sporadisch auch Nachts. Die Woche war es am Mittwoch, davor am 22.12 und davor am 29.11 also ein Muster wann es passiert ist nicht zu erkennen.
Raspi4 schaltet sich sporadisch aus
-
-
Und was sagt das Homebridge Log vor dem Shutdown? Und die anderen Sachen?
vom iobroker und homebridge nicht wirklich was spannendes. Der shutdown war um 0:49. Bei unifi steht gar nichts drin, deconz weiss ich nicht wo es ein log gibt sowie bei den restlichen Sachen auch nicht.
homebridge:
[21/02/2024, 00:17:25] [Hue] Daylight: set homekit sunset from Tue Feb 20 2024 17:43:02 to Wed Feb 21 2024 17:44:43
[21/02/2024, 00:19:18] [Hue] Feuchtigkeit Wohnzimmer: set homekit humidity from 89% to 88%
[21/02/2024, 00:19:18] [Hue] Feuchtigkeit Wohnzimmer: set homekit pressure from 1004 hPa to 1005 hPa
[21/02/2024, 00:31:02] [Hue] Feuchtigkeit Wohnzimmer: set homekit humidity from 88% to 89%
[21/02/2024, 00:31:02] [Hue] Feuchtigkeit Wohnzimmer: set homekit pressure from 1005 hPa to 1004 hPa
[21/02/2024, 00:31:13] [Hue] Daylight: set homekit status from 230 to 100
[21/02/2024, 00:31:13] [Hue] Daylight: set homekit last event from Astronomical Dusk to Solar Midnight
[21/02/2024, 00:42:40] [Hue] Feuchtigkeit Büro: set homekit pressure from 1025 hPa to 1024 hPa
[21/02/2024, 00:35:36] [HB Supervisor] OS: Linux 6.1.21-v8+ arm64
[21/02/2024, 00:35:36] [HB Supervisor] Node.js v20.9.0 /opt/homebridge/bin/node
[21/02/2024, 00:35:36] [HB Supervisor] Homebridge Path: /var/lib/homebridge/node_modules/homebridge/bin/homebridge
[21/02/2024, 00:35:36] [HB Supervisor] UI Path: /opt/homebridge/lib/node_modules/homebridge-config-ui-x/dist/bin/standalone.js
prebuild-file-path: /opt/homebridge/lib/node_modules/homebridge-config-ui-x/node_modules/@homebridge/node-pty-prebuilt-multiarch/prebuilds/linux-arm64/node.abi115.node
[21/02/2024, 00:35:46] [Homebridge UI] Homebridge UI v4.52.3 is listening on :: port 8090
[21/02/2024, 00:35:47] [HB Supervisor] Starting Homebridge with extra flags: -I -P /var/lib/homebridge/node_modules --strict-plugin-resolution
[21/02/2024, 00:35:47] [HB Supervisor] Started Homebridge v1.7.0 with PID: 1165
[21/02/2024, 06:57:10] Loaded config.json with 2 accessories and 4 platforms.
[21/02/2024, 06:57:11] Loaded 43 cached accessories from cachedAccessories.
[21/02/2024, 06:57:11] ---
[21/02/2024, 06:57:17] Loaded plugin: [email protected]
[21/02/2024, 06:57:17] Registering platform 'homebridge-hue.Hue'
[21/02/2024, 06:57:17] ---
[21/02/2024, 06:57:17] Loaded plugin: [email protected]
iobroker:
2024-02-21 00:30:00.056 - info: host.raspberry instance system.adapter.daswetter.0 started with pid 1386155 2024-02-21 00:30:02.337 - info: daswetter.0 (1386155) starting. Version 3.1.10 in /opt/iobroker/node_modules/iobroker.daswetter, node: v16.18.0, js-controller: 5.0.16 2024-02-21 00:30:14.687 - info: daswetter.0 (1386155) Terminated (ADAPTER_REQUESTED_TERMINATION): All data handled, adapter stopped until next scheduled moment 2024-02-21 00:30:15.203 - info: daswetter.0 (1386155) cleaned everything up... 2024-02-21 00:30:15.225 - info: host.raspberry instance system.adapter.daswetter.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION) 2024-02-21 00:45:00.086 - info: host.raspberry instance system.adapter.daswetter.0 started with pid 1386984 2024-02-21 00:45:02.434 - info: daswetter.0 (1386984) starting. Version 3.1.10 in /opt/iobroker/node_modules/iobroker.daswetter, node: v16.18.0, js-controller: 5.0.16 2024-02-21 00:45:14.916 - info: daswetter.0 (1386984) Terminated (ADAPTER_REQUESTED_TERMINATION): All data handled, adapter stopped until next scheduled moment 2024-02-21 00:45:15.446 - info: daswetter.0 (1386984) cleaned everything up... 2024-02-21 00:45:15.497 - info: host.raspberry instance system.adapter.daswetter.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION) 2024-02-21 00:35:39.374 - info: host.raspberry iobroker.js-controller version 5.0.16 js-controller starting 2024-02-21 00:35:39.388 - info: host.raspberry Copyright (c) 2014-2023 bluefox, 2014 hobbyquaker 2024-02-21 00:35:39.391 - info: host.raspberry hostname: raspberry, node: v16.18.0 2024-02-21 00:35:39.394 - info: host.raspberry ip addresses: 192.168.171.4 fda9:9929:6a5d:d34b:18bb:6bed:f389:504f fe80::ae91:5c5e:3398:22e3 2024-02-21 00:35:42.312 - info: host.raspberry connected to Objects and States 2024-02-21 00:35:42.450 - info: host.raspberry added notifications configuration of host 2024-02-21 00:35:43.977 - info: host.raspberry Delete state "system.host.raspberry.versions.nodeCurrent" 2024-02-21 00:35:43.980 - info: host.raspberry 15 instances found 2024-02-21 00:35:44.036 - info: host.raspberry starting 15 instances 2024-02-21 00:35:44.316 - info: host.raspberry instance system.adapter.admin.0 started with pid 1154 2024-02-21 00:35:44.355 - info: host.raspberry Delete state "system.host.raspberry.versions.nodeNewest" 2024-02-21 00:35:44.470 - info: host.raspberry Delete state "system.host.raspberry.versions.nodeNewestNext" 2024-02-21 00:35:44.501 - info: host.raspberry Delete state "system.host.raspberry.versions.npmCurrent" 2024-02-21 00:35:44.527 - info: host.raspberry Delete state "system.host.raspberry.versions.npmNewest" 2024-02-21 00:35:44.559 - info: host.raspberry Delete state "system.host.raspberry.versions.npmNewestNext" 2024-02-21 00:35:44.585 - info: host.raspberry Some obsolete host states deleted. 2024-02-21 06:57:09.154 - info: host.raspberry instance system.adapter.influxdb.0 started with pid 1180 2024-02-21 06:57:12.271 - error: admin.0 (1154) admin.0 already running 2024-02-21 06:57:12.297 - warn: admin.0 (1154) Terminated (ADAPTER_ALREADY_RUNNING): Without reason 2024-02-21 06:57:13.343 - error: host.raspberry instance system.adapter.admin.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING) 2024-02-21 06:57:13.345 - info: host.raspberry Restart adapter system.adapter.admin.0 because enabled 2024-02-21 06:57:13.460 - info: host.raspberry instance system.adapter.javascript.0 started with pid 1213 Schau dir mal sie Systemlogs an:
less /var/log/messages
less /var/log/syslog
Ich tippe auf's Netzteil.
mir scheint als ob irgendwas um 0:35 vorgefallen wäre laut messages denn nur. zu dem Zeitpunkt stehen viele Einträge drin
pi@raspberry:~ $ less /var/log/syslog
Feb 21 00:35:44 raspberry bash[879]: host.raspberry check instance "system.adapter.backitup.0" for host "raspberry"
Feb 21 00:35:44 raspberry bash[879]: host.raspberry check instance "system.adapter.deconz.0" for host "raspberry"
Feb 21 00:35:44 raspberry bash[879]: host.raspberry check instance "system.adapter.daswetter.0" for host "raspberry"
Feb 21 00:35:44 raspberry bash[879]: host.raspberry check instance "system.adapter.device-reminder.0" for host "raspberry"
Feb 21 00:35:44 raspberry bash[879]: host.raspberry check instance "system.adapter.sourceanalytix.0" for host "raspberry"
Feb 21 00:35:44 raspberry bash[879]: host.raspberry check instance "system.adapter.denon.0" for host "raspberry"
Feb 21 00:35:44 raspberry bash[879]: host.raspberry check instance "system.adapter.tankerkoenig.0" for host "raspberry"
Feb 21 00:35:44 raspberry influxd-systemd-start.sh[796]: ts=2024-02-20T23:35:44.049015Z lvl=error msg="Unable to write gathered points" log_id=0nUDq2mW000 service=scraper scraper-name="new target" error="database not found: cbdc96ce6b3cc12e"
Feb 21 00:35:47 raspberry systemd[1]: systemd-fsckd.service: Succeeded.
Feb 21 06:57:08 raspberry systemd-timesyncd[377]: Initial synchronization to time server 176.9.157.155:123 (2.debian.pool.ntp.org).
Feb 21 06:57:11 raspberry systemd[1]: systemd-timedated.service: Succeeded.
Feb 21 06:57:12 raspberry grafana[878]: logger=infra.usagestats.collector t=2024-02-21T06:57:12.701419929+01:00 level=info msg="registering usage stat providers" usageStatsProvidersLen=2
Feb 21 06:57:12 raspberry grafana[878]: logger=server t=2024-02-21T06:57:12.701850799+01:00 level=info msg="Writing PID file" path=/run/grafana/grafana-server.pid pid=878
Feb 21 06:57:12 raspberry grafana[878]: logger=provisioning.alerting t=2024-02-21T06:57:12.711425355+01:00 level=info msg="starting to provision alerting"
Feb 21 06:57:12 raspberry grafana[878]: logger=provisioning.alerting t=2024-02-21T06:57:12.711656077+01:00 level=info msg="finished to provision alerting"
Feb 21 06:57:12 raspberry grafana[878]: logger=ngalert.state.manager t=2024-02-21T06:57:12.729109077+01:00 level=info msg="Warming state cache for startup"
Feb 21 06:57:12 raspberry grafana[878]: logger=http.server t=2024-02-21T06:57:12.738330669+01:00 level=info msg="HTTP Server Listen" address=[::]:3000 protocol=http subUrl= socket=
Feb 21 06:57:12 raspberry grafana[878]: logger=grafanaStorageLogger t=2024-02-21T06:57:12.750184688+01:00 level=info msg="Storage starting"
Feb 21 06:57:12 raspberry grafana[878]: logger=grafana.update.checker t=2024-02-21T06:57:12.960528929+01:00 level=info msg="Update check succeeded" duration=246.066407ms
Feb 21 06:57:12 raspberry grafana[878]: logger=plugins.update.checker t=2024-02-21T06:57:12.984169503+01:00 level=info msg="Update check succeeded" duration=256.897537ms
Feb 21 06:57:12 raspberry grafana[878]: logger=ngalert.migration t=2024-02-21T06:57:12.991193299+01:00 level=info msg=Starting
Feb 21 06:57:12 raspberry grafana[878]: logger=ngalert.migration t=2024-02-21T06:57:12.993656095+01:00 level=info msg="No migrations to run"
Feb 21 06:57:13 raspberry bash[879]: ================================== > LOG REDIRECT system.adapter.admin.0 => false [Process stopped]
Feb 21 06:57:13 raspberry bash[879]: ================================== > LOG REDIRECT system.adapter.admin.0 => false [system.adapter.admin.0.logging]
Feb 21 06:57:13 raspberry grafana[878]: logger=ngalert.state.manager t=2024-02-21T06:57:13.755778447+01:00 level=info msg="State cache has been initialized" states=0 duration=1.026640332s
Feb 21 06:57:13 raspberry grafana[878]: logger=ngalert.scheduler t=2024-02-21T06:57:13.756110113+01:00 level=info msg="Starting scheduler" tickInterval=10s
Feb 21 06:57:13 raspberry grafana[878]: logger=ngalert.multiorg.alertmanager t=2024-02-21T06:57:13.757669947+01:00 level=info msg="Starting MultiOrg Alertmanager"
Feb 21 06:57:13 raspberry grafana[878]: logger=ticker t=2024-02-21T06:57:13.759299465+01:00 level=info msg=starting first_tick=2024-02-21T06:57:20+01:00
Feb 21 06:57:14 raspberry influxd-systemd-start.sh[796]: ts=2024-02-21T05:57:14.947512Z lvl=error msg="Unable to write gathered points" log_id=0nUDq2mW000 service=scraper scraper-name="new target" error="database not found: cbdc96ce6b3cc12e"
Feb 21 06:57:16 raspberry systemd[1]: systemd-hostnamed.service: Succeeded.
Feb 21 06:57:20 raspberry bash[879]: ================================== > LOG REDIRECT system.adapter.javascript.0 => false [Process stopped]
Feb 21 06:57:20 raspberry bash[879]: ================================== > LOG REDIRECT system.adapter.javascript.0 => false [system.adapter.javascript.0.logging]
Feb 21 06:57:24 raspberry influxd-systemd-start.sh[796]: ts=2024-02-21T05:57:24.947750Z lvl=error msg="Unable to write gathered points" log_id=0nUDq2mW000 service=scraper scraper-name="new target" error="database not found: cbdc96ce6b3cc12e"
Feb 21 06:57:35 raspberry influxd-systemd-start.sh[796]: ts=2024-02-21T05:57:35.022724Z lvl=error msg="Unable to write gathered points" log_id=0nUDq2mW000 service=scraper scraper-name="new target" error="database not found: cbdc96ce6b3cc12e"
Feb 21 06:57:44 raspberry influxd-systemd-start.sh[796]: ts=2024-02-21T05:57:44.920492Z lvl=error msg="Unable to write gathered points" log_id=0nUDq2mW000 service=scraper scraper-name="new target" error="database not found: cbdc96ce6b3cc12e"
Feb 21 06:57:54 raspberry influxd-systemd-start.sh[796]: ts=2024-02-21T05:57:54.980870Z lvl=error msg="Unable to write gathered points" log_id=0nUDq2mW000 service=scraper scraper-name="new target" error="database not found: cbdc96ce6b3cc12e"
Feb 21 06:58:04 raspberry influxd-systemd-start.sh[796]: ts=2024-02-21T05:58:04.968731Z lvl=error msg="Unable to write gathered points" log_id=0nUDq2mW000 service=scraper scraper-name="new target" error="database not found: cbdc96ce6b3cc12e"
pi@raspberry:~ $ less /var/log/messages
Feb 21 00:35:17 raspberry kernel: [ 6.488560] vc4-drm gpu: bound fef05700.hdmi (ops vc4_hdmi_ops [vc4])
Feb 21 00:35:17 raspberry mtp-probe: checking bus 1, device 3: "/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3"
Feb 21 00:35:17 raspberry mtp-probe: checking bus 2, device 2: "/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-2"
Feb 21 00:35:17 raspberry mtp-probe: checking bus 1, device 5: "/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4.4"
Feb 21 00:35:17 raspberry mtp-probe: bus: 1, device: 3 was not an MTP device
Feb 21 00:35:17 raspberry mtp-probe: bus: 2, device: 2 was not an MTP device
Feb 21 00:35:17 raspberry mtp-probe: bus: 1, device: 5 was not an MTP device
Feb 21 00:35:17 raspberry kernel: [ 6.489237] vc4-drm gpu: bound fe004000.txp (ops vc4_txp_ops [vc4])
Feb 21 00:35:17 raspberry kernel: [ 6.489887] vc4-drm gpu: bound fe206000.pixelvalve (ops vc4_crtc_ops [vc4])
Feb 21 00:35:17 raspberry kernel: [ 6.490385] vc4-drm gpu: bound fe207000.pixelvalve (ops vc4_crtc_ops [vc4])
Feb 21 00:35:17 raspberry kernel: [ 6.490894] vc4-drm gpu: bound fe20a000.pixelvalve (ops vc4_crtc_ops [vc4])
Feb 21 00:35:17 raspberry kernel: [ 6.491262] vc4-drm gpu: bound fe216000.pixelvalve (ops vc4_crtc_ops [vc4])
Feb 21 00:35:17 raspberry kernel: [ 6.491742] vc4-drm gpu: bound fec12000.pixelvalve (ops vc4_crtc_ops [vc4])
Feb 21 00:35:17 raspberry kernel: [ 6.530264] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1
Feb 21 00:35:17 raspberry kernel: [ 6.533635] vc4-drm gpu: [drm] Cannot find any crtc or sizes
Feb 21 00:35:17 raspberry kernel: [ 7.694359] 8021q: 802.1Q VLAN Support v1.8
Feb 21 00:35:17 raspberry kernel: [ 7.755062] uart-pl011 fe201000.serial: no DMA platform data
Feb 21 00:35:17 raspberry rsyslogd: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd. [v8.2102.0]
Feb 21 00:35:17 raspberry rsyslogd: [origin software="rsyslogd" swVersion="8.2102.0" x-pid="437" x-info="https://www.rsyslog.com"] start
Feb 21 00:35:18 raspberry kernel: [ 7.994173] Adding 102396k swap on /var/swap. Priority:-3 extents:1 across:102396k SSFS
Feb 21 00:35:18 raspberry kernel: [ 8.223902] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled
Feb 21 00:35:18 raspberry kernel: [ 8.576561] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
Feb 21 00:35:18 raspberry kernel: [ 8.582834] bcmgenet fd580000.ethernet eth0: Link is Down
Feb 21 00:35:18 raspberry unifi: init complete...
Feb 21 00:35:18 raspberry unifi: Skipping init-uos...
Feb 21 00:35:19 raspberry unifi: health-check max retry count: 100
Feb 21 00:35:19 raspberry kernel: [ 9.744007] generic ttyUSB0: generic converter now disconnected from ttyUSB0
Feb 21 00:35:19 raspberry kernel: [ 9.744083] usbserial_generic 1-1.4.4:1.0: device disconnected
Feb 21 00:35:23 raspberry kernel: [ 13.748694] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Feb 21 00:35:25 raspberry kernel: [ 15.090917] Bluetooth: Core ver 2.22
Feb 21 00:35:25 raspberry kernel: [ 15.091035] NET: Registered PF_BLUETOOTH protocol family
Feb 21 00:35:25 raspberry kernel: [ 15.091042] Bluetooth: HCI device and connection manager initialized
Feb 21 00:35:25 raspberry kernel: [ 15.091070] Bluetooth: HCI socket layer initialized
Feb 21 00:35:25 raspberry kernel: [ 15.091079] Bluetooth: L2CAP socket layer initialized
Feb 21 00:35:25 raspberry kernel: [ 15.091096] Bluetooth: SCO socket layer initialized
Feb 21 00:35:25 raspberry kernel: [ 15.103303] Bluetooth: HCI UART driver ver 2.3
Feb 21 00:35:25 raspberry kernel: [ 15.103329] Bluetooth: HCI UART protocol H4 registered
Feb 21 00:35:25 raspberry kernel: [ 15.103405] Bluetooth: HCI UART protocol Three-wire (H5) registered
Feb 21 00:35:25 raspberry kernel: [ 15.103607] Bluetooth: HCI UART protocol Broadcom registered
Feb 21 00:35:25 raspberry kernel: [ 15.312723] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Feb 21 00:35:25 raspberry kernel: [ 15.312750] Bluetooth: BNEP filters: protocol multicast
Feb 21 00:35:25 raspberry kernel: [ 15.312770] Bluetooth: BNEP socket layer initialized
Feb 21 00:35:25 raspberry kernel: [ 15.317770] Bluetooth: MGMT ver 1.22
Feb 21 00:35:25 raspberry kernel: [ 15.329371] NET: Registered PF_ALG protocol family
Feb 21 00:35:25 raspberry kernel: [ 15.523470] ICMPv6: process `dhcpcd' is using deprecated sysctl (syscall) net.ipv6.neigh.wlan0.retrans_time - use net.ipv6.neigh.wlan0.retrans_time_ms instead
Feb 21 00:35:34 raspberry kernel: [ 24.209063] node: epoll_ctl support in io_uring is deprecated and will be removed in a future Linux kernel version.
Feb 21 06:58:26 raspberry unifi: unifi is up and running. Health check finished successfully.
Feb 21 06:58:34 raspberry kernel: [ 123.577506] Key type cifs.spnego registered
Feb 21 06:58:34 raspberry kernel: [ 123.577536] Key type cifs.idmap registered
Feb 21 06:58:34 raspberry kernel: [ 123.581364] CIFS: Attempting to mount \\192.168.171.40\Software
Feb 21 06:58:39 raspberry kernel: [ 128.206251] CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Feb 21 06:58:39 raspberry kernel: [ 128.206272] CIFS: Attempting to mount \\192.168.171.40\Software
Feb 21 08:30:20 raspberry kernel: [ 5629.198744] CIFS: Attempting to mount \\192.168.171.40\Software
Feb 22 00:10:18 raspberry rsyslogd: [origin software="rsyslogd" swVersion="8.2102.0" x-pid="437" x-info="https://www.rsyslog.com"] rsyslogd was HUPed
Feb 22 08:30:20 raspberry kernel: [92029.702882] CIFS: Attempting to mount \\192.168.171.40\Software
Feb 23 08:30:20 raspberry kernel: [178430.363014] CIFS: Attempting to mount \\192.168.171.40\Software