IoBroker restart missglückt?
-
Ich benutze einen Raspi 4 mit 4 Gb. Das Bullseye system läuft auf einer SSD. Systemsoftware ist auf neuestem Stand.
Problem: seit einigen Wochen hängt sich der Raspi auf, sodaß nur noch ping funktioniert, nicht aber der Konsolenzugriff. Die Frequenz ist typisch einige Tage. Nach einem Neustart (Strom aus/an) läuft das System wieder einwandfrei (bis zum nächsten Mal). Ich kann leider nicht herausfinden, wo der Fehler liegt und bitte daher um Hilfe. Hier zunächst einmal ein log Ausschnitt vor dem letzten Neustart.2024-03-19 20:25:18.555 - debug: influxdb.0 (1149) Connect InfluxDB1: http://localhost:8086 [iobroker] 2024-03-19 20:25:32.025 - debug: influxdb.0 (1149) Extracted retention time for iobroker - Hours: 0 Minutes: 0 Seconds: 0 2024-03-19 20:25:32.031 - debug: influxdb.0 (1149) old retention: {"name":"autogen","time":0} new retention: 0 2024-03-19 20:25:32.032 - debug: influxdb.0 (1149) Retention policy for iobroker remains unchanged. 2024-03-19 20:25:33.706 - debug: influxdb.0 (1149) connected set to true 2024-03-19 20:25:33.707 - debug: influxdb.0 (1149) connected set to true 2024-03-19 20:26:04.028 - warn: influxdb.0 (1149) Error on writePoint("{"value":9.9,"time":"2024-03-19T19:25:32.700Z","from":"system.adapter.shelly.1","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:04.034 - debug: influxdb.0 (1149) connected set to false 2024-03-19 20:26:05.253 - warn: influxdb.0 (1149) Error on writePoint("{"value":30273.74,"time":"2024-03-19T19:25:34.875Z","from":"system.adapter.sonoff.0","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:05.255 - warn: influxdb.0 (1149) Error on writePoint("{"value":30273.75,"time":"2024-03-19T19:25:35.223Z","from":"system.adapter.sonoff.0","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:06.250 - warn: influxdb.0 (1149) Error on writePoint("{"value":372,"time":"2024-03-19T19:25:36.185Z","from":"system.adapter.javascript.0","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:06.251 - warn: influxdb.0 (1149) Error on writePoint("{"value":379,"time":"2024-03-19T19:25:36.194Z","from":"system.adapter.javascript.0","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:06.317 - warn: influxdb.0 (1149) Error on writePoint("{"value":381,"time":"2024-03-19T19:25:36.307Z","from":"system.adapter.javascript.0","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:06.442 - warn: influxdb.0 (1149) Error on writePoint("{"value":442,"time":"2024-03-19T19:25:36.426Z","from":"system.adapter.javascript.0","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:06.502 - warn: influxdb.0 (1149) Error on writePoint("{"value":480,"time":"2024-03-19T19:25:36.492Z","from":"system.adapter.javascript.0","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:06.796 - warn: influxdb.0 (1149) Error on writePoint("{"value":10.6,"time":"2024-03-19T19:25:36.792Z","from":"system.adapter.shelly.1","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:14.031 - info: influxdb.0 (1149) Connecting http://localhost:8086/ ... 2024-03-19 20:26:14.031 - info: influxdb.0 (1149) Influx DB Version used: 1.x 2024-03-19 20:26:14.031 - debug: influxdb.0 (1149) Connect InfluxDB1: http://localhost:8086 [iobroker] 2024-03-19 20:26:14.048 - debug: influxdb.0 (1149) Extracted retention time for iobroker - Hours: 0 Minutes: 0 Seconds: 0 2024-03-19 20:26:14.049 - debug: influxdb.0 (1149) old retention: {"name":"autogen","time":0} new retention: 0 2024-03-19 20:26:14.049 - debug: influxdb.0 (1149) Retention policy for iobroker remains unchanged. 2024-03-19 20:26:14.050 - debug: influxdb.0 (1149) connected set to true 2024-03-19 20:26:18.677 - warn: influxdb.0 (1149) Error on writePoint("{"value":474,"time":"2024-03-19T19:25:48.667Z","from":"system.adapter.javascript.0","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:18.678 - info: influxdb.0 (1149) Add point that had error for javascript.0.gStromc to buffer again, error-count=2 2024-03-19 20:26:21.617 - warn: influxdb.0 (1149) Error on writePoint("{"value":2.9,"time":"2024-03-19T19:25:51.609Z","from":"system.adapter.shelly.1","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:21.618 - info: influxdb.0 (1149) Add point that had error for shelly.1.shellyplus1pm#fcb467279060#1.Relay0.Power to buffer again, error-count=1 2024-03-19 20:26:27.824 - warn: influxdb.0 (1149) Error on writePoint("{"value":473,"time":"2024-03-19T19:25:57.815Z","from":"system.adapter.javascript.0","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:26:27.825 - info: influxdb.0 (1149) Add point that had error for javascript.0.gStromc to buffer again, error-count=3 2024-03-19 20:27:20.794 - warn: influxdb.0 (1149) Error on writePoint("{"value":6.7,"time":"2024-03-19T19:26:50.787Z","from":"system.adapter.shelly.1","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:27:20.807 - debug: influxdb.0 (1149) connected set to false 2024-03-19 20:27:21.084 - warn: influxdb.0 (1149) Error on writePoint("{"value":2.8,"time":"2024-03-19T19:26:51.078Z","from":"system.adapter.shelly.1","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:27:26.794 - warn: influxdb.0 (1149) Error on writePoint("{"value":9.3,"time":"2024-03-19T19:26:56.788Z","from":"system.adapter.shelly.1","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:27:30.795 - info: influxdb.0 (1149) Connecting http://localhost:8086/ ... 2024-03-19 20:27:30.796 - info: influxdb.0 (1149) Influx DB Version used: 1.x 2024-03-19 20:27:30.796 - debug: influxdb.0 (1149) Connect InfluxDB1: http://localhost:8086 [iobroker] 2024-03-19 20:27:30.809 - debug: influxdb.0 (1149) Extracted retention time for iobroker - Hours: 0 Minutes: 0 Seconds: 0 2024-03-19 20:27:30.809 - debug: influxdb.0 (1149) old retention: {"name":"autogen","time":0} new retention: 0 2024-03-19 20:27:30.810 - debug: influxdb.0 (1149) Retention policy for iobroker remains unchanged. 2024-03-19 20:27:30.816 - debug: influxdb.0 (1149) connected set to true 2024-03-19 20:27:43.803 - warn: influxdb.0 (1149) Error on writePoint("{"value":8.1,"time":"2024-03-19T19:27:13.793Z","from":"system.adapter.shelly.1","q":0,"ack":true}): Error: ESOCKETTIMEDOUT / "ESOCKETTIMEDOUT"" 2024-03-19 20:27:43.804 - info: influxdb.0 (1149) Add point that had error for shelly.1.shellyplusplugs#d4d4daebcba4#1.Relay0.Power to buffer again, error-count=6 2024-03-19 20:30:43.987 - info: influxdb.0 (1149) Store 15 buffered influxDB history points 2024-03-19 20:36:13.433 - info: onkyo.0 (1331) Successfully connected to AVR 2024-03-19 20:40:59.673 - info: javascript.0 (1201) script.js.Sensoren.Heizung.Heizung_T_Wz: Temperatur Wz: 19.6 passed &&&upper&&& T limit: 19.6 2024-03-19 20:43:56.218 - info: alexa2.0 (189642) Alexa-Push-Connection disconnected - retry: Retry Connection in 1s 2024-03-19 20:43:57.632 - info: alexa2.0 (189642) Alexa-Push-Connection (macDms = true) established. Disable Polling 2024-03-19 20:30:43.607 - info: host.raspibull iobroker.js-controller version 5.0.17 js-controller starting 2024-03-19 20:30:43.615 - info: host.raspibull Copyright (c) 2014-2023 bluefox, 2014 hobbyquaker 2024-03-19 20:30:43.616 - info: host.raspibull hostname: raspibull, node: v18.19.0 2024-03-19 20:30:43.617 - info: host.raspibull ip addresses: 192.168.178.78 2003:cf:9f02:300:c184:5a97:2abe:4625 fe80::ccc:2f5:c76b:81ed 2003:cf:9f02:300:d5:dd7b:5947:6921 fe80::8f31:1fe9:478a:1454 2024-03-19 20:30:46.396 - info: host.raspibull connected to Objects and States 2024-03-19 20:30:46.460 - info: host.raspibull added notifications configuration of host 2024-03-19 20:30:47.967 - info: host.raspibull Delete state "system.host.raspibull.versions.nodeCurrent" 2024-03-19 20:30:48.082 - info: host.raspibull 41 instances found 2024-03-19 20:30:48.266 - info: host.raspibull starting 27 instances 2024-03-19 20:30:48.654 - info: host.raspibull Delete state "system.host.raspibull.versions.nodeNewest" 2024-03-19 20:30:48.668 - info: host.raspibull Delete state "system.host.raspibull.versions.nodeNewestNext" 2024-03-19 20:30:48.692 - info: host.raspibull instance system.adapter.admin.0 started with pid 1109 2024-03-19 20:30:48.726 - info: host.raspibull Delete state "system.host.raspibull.versions.npmCurrent" 2024-03-19 20:30:48.736 - info: host.raspibull Delete state "system.host.raspibull.versions.npmNewest" 2024-03-19 20:30:48.747 - info: host.raspibull Delete state "system.host.raspibull.versions.npmNewestNext" 2024-03-19 20:30:48.757 - info: host.raspibull Some obsolete host states deleted. 2024-03-19 20:30:51.566 - error: admin.0 (1109) admin.0 already running 2024-03-19 20:30:51.571 - warn: admin.0 (1109) Terminated (ADAPTER_ALREADY_RUNNING): Without reason 2024-03-19 20:30:52.451 - error: host.raspibull instance system.adapter.admin.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING) 2024-03-19 20:30:52.452 - info: host.raspibull Restart adapter system.adapter.admin.0 because enabled 2024-03-19 20:30:52.740 - info: host.raspibull instance system.adapter.email.0 started with pid 1130 2024-03-19 20:30:54.582 - error: email.0 (1130) email.0 already running 2024-03-19 20:30:54.588 - warn: email.0 (1130) Terminated (ADAPTER_ALREADY_RUNNING): Without reason 2024-03-19 20:30:55.414 - error: host.raspibull instance system.adapter.email.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING) 2024-03-19 20:30:55.415 - info: host.raspibull Restart adapter system.adapter.email.0 because enabled 2024-03-19 20:30:56.550 - info: host.raspibull instance system.adapter.history.0 started with pid 1151 2024-03-19 22:48:34.743 - info: history.0 (1151) starting. Version 3.0.1 in /opt/iobroker/node_modules/iobroker.history, node: v18.19.0, js-controller: 5.0.17 2024-03-19 22:48:34.890 - info: history.0 (1151) enabled logging of zigbee.0.00158d0002ca02cd.temperature (Count=1), Alias=false 2024-03-19 22:48:34.892 - info: history.0 (1151) enabled logging of zigbee.0.00158d000366790e.occupancy (Count=2), Alias=false 2024-03-19 22:48:34.892 - info: history.0 (1151) enabled logging of zigbee.0.0c4314fffee3cc6d.local_temperature (Count=3), Alias=false 2024-03-19 22:48:34.894 - info: history.0 (1151) enabled logging of zigbee.0.842e14fffe1394aa.load_power (Count=4), Alias=false 2024-03-19 22:48:34.895 - info: history.0 (1151) enabled logging of zigbee.0.84fd27fffe2dcb8a.local_temperature (Count=5), Alias=false 2024-03-19 22:48:34.895 - info: history.0 (1151) enabled logging of zigbee.0.84fd27fffe31a812.local_temperature (Count=6), Alias=false 2024-03-19 22:48:34.896 - info: history.0 (1151) enabled logging of system.adapter.weatherunderground.0.alive (Count=7), Alias=falseDie Probleme scheinen mit Schreibfehlern von influxdb anzufangen (habe ich auch früher schon gesehen). Um 20:30:43 scheint IoBroker neu starten zu wollen. Diese Ablaufsequenz habe ich auch schon bei früheren Stops gesehen. Nach dem Stop steigt der Stromverbrauch des Raspi deutlich an und die SSD wird richtig warm.
Hier auch noch das dmesg log nach dem Neustart:pi@raspibull:~ $ dmesg [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083] [ 0.000000] Linux version 6.1.21-v8+ (dom@buildbot) (aarch64-linux-gnu-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1642 SMP PREEMPT Mon Apr 3 17:24:16 BST 2023 [ 0.000000] random: crng init done [ 0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.1 [ 0.000000] efi: UEFI not found. [ 0.000000] Reserved memory: created CMA memory pool at 0x000000000ec00000, size 512 MiB [ 0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000000000-0x000000003fffffff] [ 0.000000] DMA32 [mem 0x0000000040000000-0x00000000fbffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000000000-0x000000003b2fffff] [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000fbffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff] [ 0.000000] On node 0, zone DMA32: 19712 pages in unavailable ranges [ 0.000000] On node 0, zone DMA32: 16384 pages in unavailable ranges [ 0.000000] percpu: Embedded 29 pages/cpu s78504 r8192 d32088 u118784 [ 0.000000] pcpu-alloc: s78504 r8192 d32088 u118784 alloc=29*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: Spectre-v2 [ 0.000000] CPU features: detected: Spectre-v3a [ 0.000000] CPU features: detected: Spectre-v4 [ 0.000000] CPU features: detected: Spectre-BHB [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) [ 0.000000] CPU features: detected: ARM erratum 1742098 [ 0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923 [ 0.000000] alternatives: applying boot alternatives [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 996660 [ 0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0 smsc95xx.macaddr=DC:A6:32:12:1E:93 vc_mem.mem_base=0x3eb00000 vc_mem.mem_size=0x3ff00000 console=ttyAMA0,115200 console=tty1 root=PARTUUID=4d904d30-02 rootfstype=ext4 fsck.repair=yes rootwait rootdelay=5 [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] software IO TLB: area num 4. [ 0.000000] software IO TLB: mapped [mem 0x0000000037300000-0x000000003b300000] (64MB) [ 0.000000] Memory: 3355924K/4049920K available (11776K kernel code, 2106K rwdata, 3688K rodata, 4160K init, 1077K bss, 169708K reserved, 524288K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] ftrace: allocating 39744 entries in 156 pages [ 0.000000] ftrace: allocated 156 pages with 4 groups [ 0.000000] trace event string verifier disabled [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] Root IRQ handler: gic_handle_irq [ 0.000000] GIC: Using split EOI/Deactivate mode [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. [ 0.000000] arch_timer: cp15 timer(s) running at 54.00MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns [ 0.000001] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns [ 0.000313] Console: colour dummy device 80x25 [ 0.000936] printk: console [tty1] enabled [ 0.001009] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000) [ 0.001051] pid_max: default: 32768 minimum: 301 [ 0.001195] LSM: Security Framework initializing [ 0.001417] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.001497] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.002826] cgroup: Disabling memory control group subsystem [ 0.005101] cblist_init_generic: Setting adjustable number of callback queues. [ 0.005138] cblist_init_generic: Setting shift to 2 and lim to 1. [ 0.005335] cblist_init_generic: Setting shift to 2 and lim to 1. [ 0.005526] cblist_init_generic: Setting shift to 2 and lim to 1. [ 0.005995] rcu: Hierarchical SRCU implementation. [ 0.006020] rcu: Max phase no-delay instances is 1000. [ 0.007364] EFI services will not be available. [ 0.007992] smp: Bringing up secondary CPUs ... [ 0.009086] Detected PIPT I-cache on CPU1 [ 0.009240] CPU1: Booted secondary processor 0x0000000001 [0x410fd083] [ 0.010407] Detected PIPT I-cache on CPU2 [ 0.010525] CPU2: Booted secondary processor 0x0000000002 [0x410fd083] [ 0.011656] Detected PIPT I-cache on CPU3 [ 0.011781] CPU3: Booted secondary processor 0x0000000003 [0x410fd083] [ 0.011963] smp: Brought up 1 node, 4 CPUs [ 0.012055] SMP: Total of 4 processors activated. [ 0.012076] CPU features: detected: 32-bit EL0 Support [ 0.012096] CPU features: detected: 32-bit EL1 Support [ 0.012118] CPU features: detected: CRC32 instructions [ 0.012267] CPU: All CPU(s) started at EL2 [ 0.012301] alternatives: applying system-wide alternatives [ 0.014146] devtmpfs: initialized [ 0.026110] Enabled cp15_barrier support [ 0.026174] Enabled setend support [ 0.026411] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.026464] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.039449] pinctrl core: initialized pinctrl subsystem [ 0.040415] DMI not present or invalid. [ 0.041119] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.044748] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations [ 0.045070] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.046051] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.046162] audit: initializing netlink subsys (disabled) [ 0.046451] audit: type=2000 audit(0.044:1): state=initialized audit_enabled=0 res=1 [ 0.047062] thermal_sys: Registered thermal governor 'step_wise' [ 0.047156] cpuidle: using governor menu [ 0.047593] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.047810] ASID allocator initialised with 32768 entries [ 0.047988] Serial: AMBA PL011 UART driver [ 0.061667] bcm2835-mbox fe00b880.mailbox: mailbox enabled [ 0.084331] raspberrypi-firmware soc:firmware: Attached to firmware from 2023-03-17T10:50:39, variant start [ 0.088346] raspberrypi-firmware soc:firmware: Firmware hash is 82f3750a65fadae9a38077e3c2e217ad158c8d54 [ 0.104566] KASLR enabled [ 0.138701] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1 [ 0.144606] SCSI subsystem initialized [ 0.144881] usbcore: registered new interface driver usbfs [ 0.144954] usbcore: registered new interface driver hub [ 0.145035] usbcore: registered new device driver usb [ 0.145445] usb_phy_generic phy: supply vcc not found, using dummy regulator [ 0.145692] usb_phy_generic phy: dummy supplies not allowed for exclusive requests [ 0.146078] pps_core: LinuxPPS API ver. 1 registered [ 0.146103] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> [ 0.146146] PTP clock support registered [ 0.147298] vgaarb: loaded [ 0.148101] clocksource: Switched to clocksource arch_sys_counter [ 0.148778] VFS: Disk quotas dquot_6.6.0 [ 0.148873] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.149082] FS-Cache: Loaded [ 0.149273] CacheFiles: Loaded [ 0.160387] NET: Registered PF_INET protocol family [ 0.161284] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.166258] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [ 0.166342] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.166385] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 0.166613] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) [ 0.167629] TCP: Hash tables configured (established 32768 bind 32768) [ 0.167890] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.167993] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [ 0.168394] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.169219] RPC: Registered named UNIX socket transport module. [ 0.169252] RPC: Registered udp transport module. [ 0.169272] RPC: Registered tcp transport module. [ 0.169291] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.169327] PCI: CLS 0 bytes, default 64 [ 0.172123] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available [ 0.172546] kvm [1]: IPA Size Limit: 44 bits [ 0.173899] kvm [1]: vgic interrupt IRQ9 [ 0.174159] kvm [1]: Hyp mode initialized successfully [ 1.333062] Initialise system trusted keyrings [ 1.333562] workingset: timestamp_bits=46 max_order=20 bucket_order=0 [ 1.341134] zbud: loaded [ 1.344178] NFS: Registering the id_resolver key type [ 1.344233] Key type id_resolver registered [ 1.344256] Key type id_legacy registered [ 1.344381] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 1.344410] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... [ 1.345852] Key type asymmetric registered [ 1.345884] Asymmetric key parser 'x509' registered [ 1.345991] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 1.346293] io scheduler mq-deadline registered [ 1.346323] io scheduler kyber registered [ 1.348555] irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7ef00100, parent irq: 27) [ 1.357488] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: [ 1.357554] brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] [ 1.357661] brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 [ 1.357764] brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000 [ 1.358833] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 [ 1.358867] pci_bus 0000:00: root bus resource [bus 00-ff] [ 1.358896] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) [ 1.358987] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 [ 1.359263] pci 0000:00:00.0: PME# supported from D0 D3hot [ 1.363256] pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring [ 1.363558] pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator [ 1.363779] pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator [ 1.363898] pci_bus 0000:01: supply vpcie12v not found, using dummy regulator [ 1.410198] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) [ 1.410383] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 [ 1.410523] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] [ 1.411021] pci 0000:01:00.0: PME# supported from D0 D3cold [ 1.411781] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 [ 1.411841] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] [ 1.411878] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] [ 1.411937] pci 0000:00:00.0: PCI bridge to [bus 01] [ 1.411970] pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] [ 1.423220] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled [ 1.426510] iproc-rng200 fe104000.rng: hwrng registered [ 1.427140] vc-mem: phys_addr:0x00000000 mem_base=0x3eb00000 mem_size:0x3ff00000(1023 MiB) [ 1.428786] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000 [ 1.442038] brd: module loaded [ 1.450949] loop: module loaded [ 1.451845] Loading iSCSI transport class v2.0-870. [ 1.457359] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 [ 1.516267] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus [ 1.517455] usbcore: registered new interface driver r8152 [ 1.517545] usbcore: registered new interface driver lan78xx [ 1.517618] usbcore: registered new interface driver smsc95xx [ 1.519250] pci 0000:00:00.0: enabling device (0000 -> 0002) [ 1.519305] xhci_hcd 0000:01:00.0: enabling device (0000 -> 0002) [ 1.519435] xhci_hcd 0000:01:00.0: xHCI Host Controller [ 1.519478] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 [ 1.520307] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000e40000000890 [ 1.521020] xhci_hcd 0000:01:00.0: xHCI Host Controller [ 1.521069] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 [ 1.521105] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed [ 1.521475] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 [ 1.521510] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 1.521538] usb usb1: Product: xHCI Host Controller [ 1.521561] usb usb1: Manufacturer: Linux 6.1.21-v8+ xhci-hcd [ 1.521584] usb usb1: SerialNumber: 0000:01:00.0 [ 1.522341] hub 1-0:1.0: USB hub found [ 1.522425] hub 1-0:1.0: 1 port detected [ 1.523451] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01 [ 1.523488] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 1.523516] usb usb2: Product: xHCI Host Controller [ 1.523539] usb usb2: Manufacturer: Linux 6.1.21-v8+ xhci-hcd [ 1.523562] usb usb2: SerialNumber: 0000:01:00.0 [ 1.524319] hub 2-0:1.0: USB hub found [ 1.524401] hub 2-0:1.0: 4 ports detected [ 1.526198] dwc_otg: version 3.00a 10-AUG-2012 (platform bus) [ 1.526563] dwc_otg: FIQ enabled [ 1.526574] dwc_otg: NAK holdoff enabled [ 1.526585] dwc_otg: FIQ split-transaction FSM enabled [ 1.526605] Module dwc_common_port init [ 1.527172] usbcore: registered new interface driver uas [ 1.527316] usbcore: registered new interface driver usb-storage [ 1.527548] mousedev: PS/2 mouse device common for all mice [ 1.533848] sdhci: Secure Digital Host Controller Interface driver [ 1.533888] sdhci: Copyright(c) Pierre Ossman [ 1.534604] sdhci-pltfm: SDHCI platform and OF driver helper [ 1.538317] ledtrig-cpu: registered to indicate activity on CPUs [ 1.538714] hid: raw HID events driver (C) Jiri Kosina [ 1.538949] usbcore: registered new interface driver usbhid [ 1.538976] usbhid: USB HID core driver [ 1.548305] NET: Registered PF_PACKET protocol family [ 1.548458] Key type dns_resolver registered [ 1.549816] registered taskstats version 1 [ 1.549910] Loading compiled-in X.509 certificates [ 1.550852] Key type .fscrypt registered [ 1.550883] Key type fscrypt-provisioning registered [ 1.566846] uart-pl011 fe201000.serial: there is not valid maps for state default [ 1.567604] uart-pl011 fe201000.serial: cts_event_workaround enabled [ 1.567783] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2 [ 1.780142] usb 1-1: new high-speed USB device number 2 using xhci_hcd [ 1.786609] printk: console [ttyAMA0] enabled [ 2.003446] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 [ 2.019003] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer [ 2.020458] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 [ 2.020915] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver [ 2.025733] usb 1-1: Product: USB2.0 Hub [ 2.027090] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 [ 2.031912] hub 1-1:1.0: USB hub found [ 2.034879] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated [ 2.070736] mmc1: Controller never released inhibit bit(s). [ 2.076560] hub 1-1:1.0: 4 ports detected [ 2.088543] of_cfs_init [ 2.119628] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA [ 2.121230] of_cfs_init: OK [ 2.136473] usb 2-2: new SuperSpeed USB device number 2 using xhci_hcd [ 2.182131] mmc1: new high speed SDIO card at address 0001 [ 2.209896] usb 2-2: New USB device found, idVendor=152d, idProduct=0583, bcdDevice= 2.08 [ 3.069998] usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 3.070014] usb 2-2: Product: USB to PCIE Bridge [ 3.081830] usb 2-2: Manufacturer: JMicron [ 3.081843] usb 2-2: SerialNumber: 0123456789ABCDEF [ 3.091003] Waiting 5 sec before mounting root device... [ 3.099118] scsi host0: uas [ 3.103542] scsi 0:0:0:0: Direct-Access JMicron Generic 0208 PQ: 0 ANSI: 6 [ 3.115204] sd 0:0:0:0: [sda] 1000215216 512-byte logical blocks: (512 GB/477 GiB) [ 3.122891] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 3.128386] sd 0:0:0:0: [sda] Write Protect is off [ 3.133229] sd 0:0:0:0: [sda] Mode Sense: 5f 00 00 08 [ 3.133641] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 3.143214] sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes [ 3.149537] sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes) [ 3.160135] usb 1-1.3: new full-speed USB device number 3 using xhci_hcd [ 3.275638] usb 1-1.3: New USB device found, idVendor=10c4, idProduct=ea60, bcdDevice= 1.00 [ 3.284061] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 3.291420] usb 1-1.3: Product: Sonoff Zigbee 3.0 USB Dongle Plus [ 3.297545] usb 1-1.3: Manufacturer: ITead [ 3.301669] usb 1-1.3: SerialNumber: 323adb3b74d9eb11b6e6178e6fe9f4d9 [ 5.503480] sda: sda1 sda2 sda3 [ 5.507557] sd 0:0:0:0: [sda] Attached SCSI disk [ 8.169169] EXT4-fs (sda2): INFO: recovery required on readonly filesystem [ 8.176115] EXT4-fs (sda2): write access will be enabled during recovery [ 9.213755] EXT4-fs (sda2): orphan cleanup on readonly fs [ 9.227435] EXT4-fs (sda2): 4 orphan inodes deleted [ 9.232387] EXT4-fs (sda2): recovery complete [ 9.240986] EXT4-fs (sda2): mounted filesystem with ordered data mode. Quota mode: none. [ 9.249231] VFS: Mounted root (ext4 filesystem) readonly on device 8:2. [ 9.257949] devtmpfs: mounted [ 9.269556] Freeing unused kernel memory: 4160K [ 9.274330] Run /sbin/init as init process [ 9.278464] with arguments: [ 9.278475] /sbin/init [ 9.278486] with environment: [ 9.278496] HOME=/ [ 9.278507] TERM=linux [ 9.415256] systemd[1]: System time before build time, advancing clock. [ 9.570933] NET: Registered PF_INET6 protocol family [ 9.577889] Segment Routing with IPv6 [ 9.581653] In-situ OAM (IOAM) with IPv6 [ 9.632353] systemd[1]: systemd 247.3-7+deb11u4 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +ZSTD +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=unified) [ 9.656608] systemd[1]: Detected architecture arm64. [ 9.669304] systemd[1]: Set hostname to <raspibull>. [ 9.854878] uart-pl011 fe201000.serial: no DMA platform data [ 10.310038] systemd[1]: Queued start job for default target Multi-User System. [ 10.333814] systemd[1]: Created slice system-getty.slice. [ 10.341131] systemd[1]: Created slice system-modprobe.slice. [ 10.348262] systemd[1]: Created slice system-serial\x2dgetty.slice. [ 10.355902] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ 10.363405] systemd[1]: Created slice User and Session Slice. [ 10.370051] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 10.378913] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 10.387879] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. [ 10.397903] systemd[1]: Reached target Local Encrypted Volumes. [ 10.404413] systemd[1]: Reached target Paths. [ 10.409243] systemd[1]: Reached target Slices. [ 10.414126] systemd[1]: Reached target Swap. [ 10.419736] systemd[1]: Listening on Syslog Socket. [ 10.425716] systemd[1]: Listening on fsck to fsckd communication Socket. [ 10.433154] systemd[1]: Listening on initctl Compatibility Named Pipe. [ 10.441313] systemd[1]: Listening on Journal Audit Socket. [ 10.447970] systemd[1]: Listening on Journal Socket (/dev/log). [ 10.455291] systemd[1]: Listening on Journal Socket. [ 10.462175] systemd[1]: Listening on udev Control Socket. [ 10.468867] systemd[1]: Listening on udev Kernel Socket. [ 10.475490] systemd[1]: Condition check resulted in Huge Pages File System being skipped. [ 10.508606] systemd[1]: Mounting POSIX Message Queue File System... [ 10.519921] systemd[1]: Mounting RPC Pipe File System... [ 10.530851] systemd[1]: Mounting Kernel Debug File System... [ 10.541988] systemd[1]: Mounting Kernel Trace File System... [ 10.548612] systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. [ 10.563195] systemd[1]: Starting Restore / save the current clock... [ 10.575434] systemd[1]: Starting Set the console keyboard layout... [ 10.587512] systemd[1]: Starting Create list of static device nodes for the current kernel... [ 10.602386] systemd[1]: Starting Load Kernel Module configfs... [ 10.614690] systemd[1]: Starting Load Kernel Module drm... [ 10.626873] systemd[1]: Starting Load Kernel Module fuse... [ 10.635214] systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. [ 10.649488] systemd[1]: Starting File System Check on Root Device... [ 10.666219] systemd[1]: Starting Journal Service... [ 10.694465] systemd[1]: Starting Load Kernel Modules... [ 10.713103] fuse: init (API version 7.37) [ 10.717723] systemd[1]: Starting Coldplug All udev Devices... [ 10.747109] systemd[1]: Mounted POSIX Message Queue File System. [ 10.758376] systemd[1]: Mounted RPC Pipe File System. [ 10.765119] systemd[1]: Mounted Kernel Debug File System. [ 10.775718] systemd[1]: Mounted Kernel Trace File System. [ 10.783932] systemd[1]: Finished Restore / save the current clock. [ 10.797464] systemd[1]: Finished Create list of static device nodes for the current kernel. [ 10.813773] systemd[1]: modprobe@configfs.service: Succeeded. [ 10.821969] systemd[1]: Finished Load Kernel Module configfs. [ 10.830673] systemd[1]: modprobe@drm.service: Succeeded. [ 10.837702] systemd[1]: Finished Load Kernel Module drm. [ 10.845803] systemd[1]: modprobe@fuse.service: Succeeded. [ 10.853128] systemd[1]: Finished Load Kernel Module fuse. [ 10.861711] systemd[1]: Finished Load Kernel Modules. [ 10.900672] systemd[1]: Mounting FUSE Control File System... [ 10.911984] systemd[1]: Mounting Kernel Configuration File System... [ 10.923297] systemd[1]: Started File System Check Daemon to report status. [ 10.939398] systemd[1]: Starting Apply Kernel Variables... [ 10.953315] systemd[1]: Finished File System Check on Root Device. [ 10.961231] systemd[1]: Mounted FUSE Control File System. [ 10.967977] systemd[1]: Mounted Kernel Configuration File System. [ 10.983833] systemd[1]: Starting Remount Root and Kernel File Systems... [ 11.006471] systemd[1]: Finished Apply Kernel Variables. [ 11.076642] systemd[1]: Started Journal Service. [ 11.157698] EXT4-fs (sda2): re-mounted. Quota mode: none. [ 11.220289] systemd-journald[150]: Received client request to flush runtime journal. [ 11.226779] systemd-journald[150]: File /var/log/journal/1ffd49df1b3a44ffb614b2c58029c285/system.journal corrupted or uncleanly shut down, renaming and replacing. [ 12.122610] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [ 12.123804] mc: Linux media interface: v0.10 [ 12.184960] videodev: Linux video capture interface: v2.00 [ 12.235281] bcm2835_vc_sm_cma_probe: Videocore shared memory driver [ 12.235323] [vc_sm_connected_init]: start [ 12.240656] [vc_sm_connected_init]: installed successfully [ 12.329389] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. [ 12.352920] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [ 12.365276] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. [ 12.377572] bcm2835_audio bcm2835_audio: card created with 8 channels [ 12.395390] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. [ 12.397490] brcmstb-i2c fef04500.i2c: @97500hz registered in polling mode [ 12.398378] brcmstb-i2c fef09500.i2c: @97500hz registered in polling mode [ 12.424635] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. [ 12.441205] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 [ 12.446647] rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. [ 12.459885] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 [ 12.469658] bcm2835-codec bcm2835-codec: Device registered as /dev/video10 [ 12.469677] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 [ 12.469722] bcm2835-codec bcm2835-codec: Loaded V4L2 decode [ 12.470374] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 [ 12.470408] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [ 12.470432] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [ 12.470451] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [ 12.470469] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [ 12.482152] bcm2835-codec bcm2835-codec: Device registered as /dev/video11 [ 12.482214] bcm2835-codec bcm2835-codec: Loaded V4L2 encode [ 12.486451] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 [ 12.488447] rpivid feb10000.codec: Device registered as /dev/video19 [ 12.488593] bcm2835-codec bcm2835-codec: Device registered as /dev/video12 [ 12.488642] bcm2835-codec bcm2835-codec: Loaded V4L2 isp [ 12.491756] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 [ 12.492268] bcm2835-codec bcm2835-codec: Device registered as /dev/video18 [ 12.492331] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx [ 12.492573] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 [ 12.500069] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 [ 12.500246] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [ 12.500272] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [ 12.500292] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [ 12.500311] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [ 12.500697] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp [ 12.536426] bcm2835-codec bcm2835-codec: Device registered as /dev/video31 [ 12.536486] bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image [ 12.961282] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0 [ 13.035425] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 13.059837] usbcore: registered new interface driver usbserial_generic [ 13.059987] usbserial: USB Serial support registered for generic [ 13.076446] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 13.077736] usbcore: registered new interface driver cp210x [ 13.086080] cfg80211: loaded regulatory.db is malformed or signature is missing/invalid [ 13.101401] usbserial: USB Serial support registered for cp210x [ 13.112135] cp210x 1-1.3:1.0: cp210x converter detected [ 13.204955] usb 1-1.3: cp210x converter now attached to ttyUSB0 [ 13.212310] sd 0:0:0:0: Attached scsi generic sg0 type 0 [ 13.259050] vc4-drm gpu: bound fe400000.hvs (ops vc4_hvs_ops [vc4]) [ 13.273320] brcmfmac: F1 signature read @0x18000000=0x15264345 [ 13.305301] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 [ 13.448668] Registered IR keymap rc-cec [ 13.470922] rc rc0: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0 [ 13.558821] input: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0/input0 [ 13.562682] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 [ 13.568347] usbcore: registered new interface driver brcmfmac [ 13.905150] vc4-drm gpu: bound fef00700.hdmi (ops vc4_hdmi_ops [vc4]) [ 13.959706] Registered IR keymap rc-cec [ 13.959941] rc rc1: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1 [ 13.960216] input: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1/input1 [ 13.983467] vc4-drm gpu: bound fef05700.hdmi (ops vc4_hdmi_ops [vc4]) [ 13.984201] vc4-drm gpu: bound fe004000.txp (ops vc4_txp_ops [vc4]) [ 13.984770] vc4-drm gpu: bound fe206000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 13.985245] vc4-drm gpu: bound fe207000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 13.985701] vc4-drm gpu: bound fe20a000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 13.986025] vc4-drm gpu: bound fe216000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 13.986530] vc4-drm gpu: bound fec12000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 14.033941] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1 [ 14.037619] vc4-drm gpu: [drm] Cannot find any crtc or sizes [ 22.632763] EXT4-fs (sda3): recovery complete [ 22.633246] EXT4-fs (sda3): mounted filesystem with ordered data mode. Quota mode: none. [ 23.351316] 8021q: 802.1Q VLAN Support v1.8 [ 23.534849] Adding 2076668k swap on /var/swap. Priority:-2 extents:26 across:6004736k SSFS [ 23.628285] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 23.912383] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) [ 23.914642] bcmgenet fd580000.ethernet eth0: Link is Down [ 28.004276] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx [ 28.004319] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 29.694510] ICMPv6: process `dhcpcd' is using deprecated sysctl (syscall) net.ipv6.neigh.eth0.retrans_time - use net.ipv6.neigh.eth0.retrans_time_ms instead [ 34.722319] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes readyMeine erste Frage, bringt influxdb den IoBroker zum Absturz?
HUK -
@hukio sagte in IoBroker restart missglückt?:
Das Bullseye system läuft auf einer SSD. Systemsoftware ist auf neuestem Stand.
Ohne auf deine Fehler einzugehen.
Bullseye ist EOL und bekommt keine Updates mehr. Da bist schon lange am veralteten aktuellen Stand.Am besten mal iob diag in der langfassung posten.
-
@hukio sagte in IoBroker restart missglückt?:
Die Probleme scheinen mit Schreibfehlern von influxdb anzufangen
steht influxdb absichtlich auf debug?
@hukio sagte in IoBroker restart missglückt?:
2024-03-19 20:30:48.082 - info: host.raspibull 41 instances found
2024-03-19 20:30:48.266 - info: host.raspibull starting 27 instancesist für
@hukio sagte in IoBroker restart missglückt?:
Raspi 4 mit 4 Gb
denke ich auch schon am Limit
-
@david-g
Hier ist das ausführliche diag:Skript v.2023-10-10 *** BASE SYSTEM *** Static hostname: raspibull Icon name: computer Operating System: Debian GNU/Linux 11 (bullseye) Kernel: Linux 6.1.21-v8+ Architecture: arm64 Model : Raspberry Pi 4 Model B Rev 1.1 Docker : false Virtualization : none Kernel : aarch64 Userland : arm64 Systemuptime and Load: 14:29:50 up 15:42, 1 user, load average: 0.56, 0.69, 0.59 CPU threads: 4 *** RASPBERRY THROTTLING *** Current issues: No throttling issues detected. Previously detected issues: No throttling issues detected. *** Time and Time Zones *** Local time: Wed 2024-03-20 14:29:51 CET Universal time: Wed 2024-03-20 13:29:51 UTC RTC time: n/a Time zone: Europe/Berlin (CET, +0100) System clock synchronized: yes NTP service: active RTC in local TZ: no *** User and Groups *** pi /home/pi pi adm dialout cdrom sudo audio video plugdev games users input render netdev gpio i2c spi iobroker *** X-Server-Setup *** X-Server: false Desktop: Terminal: tty Boot Target: multi-user.target *** MEMORY *** total used free shared buff/cache available Mem: 3.8G 2.6G 266M 1.0M 879M 1.2G Swap: 2.0G 0B 2.0G Total: 5.8G 2.6G 2.3G 3793 M total memory 2647 M used memory 2825 M active memory 549 M inactive memory 266 M free memory 366 M buffer memory 513 M swap cache 2027 M total swap 0 M used swap 2027 M free swap Raspberry only: oom events: 0 lifetime oom required: 0 Mbytes total time in oom handler: 0 ms max time spent in oom handler: 0 ms *** FAILED SERVICES *** UNIT LOAD ACTIVE SUB DESCRIPTION 0 loaded units listed. *** FILESYSTEM *** Filesystem Type Size Used Avail Use% Mounted on /dev/root ext4 30G 20G 8.3G 71% / devtmpfs devtmpfs 1.7G 0 1.7G 0% /dev tmpfs tmpfs 1.9G 0 1.9G 0% /dev/shm tmpfs tmpfs 759M 1.2M 758M 1% /run tmpfs tmpfs 5.0M 4.0K 5.0M 1% /run/lock /dev/sda1 vfat 256M 32M 225M 13% /boot /dev/sda3 ext4 439G 1.9G 415G 1% /mnt/hukdata tmpfs tmpfs 380M 0 380M 0% /run/user/1000 Messages concerning ext4 filesystem in dmesg: [Tue Mar 19 22:47:40 2024] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0 smsc95xx.macaddr=DC:A6:32:12:1E:93 vc_mem.mem_base=0x3eb00000 vc_mem.mem_size=0x3ff00000 console=ttyAMA0,115200 console=tty1 root=PARTUUID=4d904d30-02 rootfstype=ext4 fsck.repair=yes rootwait rootdelay=5 [Tue Mar 19 22:47:48 2024] EXT4-fs (sda2): INFO: recovery required on readonly filesystem [Tue Mar 19 22:47:48 2024] EXT4-fs (sda2): write access will be enabled during recovery [Tue Mar 19 22:47:49 2024] EXT4-fs (sda2): orphan cleanup on readonly fs [Tue Mar 19 22:47:49 2024] EXT4-fs (sda2): 4 orphan inodes deleted [Tue Mar 19 22:47:49 2024] EXT4-fs (sda2): recovery complete [Tue Mar 19 22:47:49 2024] EXT4-fs (sda2): mounted filesystem with ordered data mode. Quota mode: none. [Tue Mar 19 22:47:49 2024] VFS: Mounted root (ext4 filesystem) readonly on device 8:2. [Tue Mar 19 22:47:51 2024] EXT4-fs (sda2): re-mounted. Quota mode: none. [Tue Mar 19 22:48:02 2024] EXT4-fs (sda3): recovery complete [Tue Mar 19 22:48:02 2024] EXT4-fs (sda3): mounted filesystem with ordered data mode. Quota mode: none. Show mounted filesystems \(real ones only\): TARGET SOURCE FSTYPE OPTIONS / /dev/sda2 ext4 rw,noatime |-/boot /dev/sda1 vfat rw,relatime,fmask=0022,dmask=0022,codepage=437,iocharset=ascii,shortname=mixed,errors=remount-ro `-/mnt/hukdata /dev/sda3 ext4 rw,noatime Files in neuralgic directories: /var: 5.8G /var/ 3.1G /var/log 3.0G /var/log/journal/1ffd49df1b3a44ffb614b2c58029c285 3.0G /var/log/journal 563M /var/cache Archived and active journals take up 2.9G in the file system. /opt/iobroker/backups: 8.4G /opt/iobroker/backups/ /opt/iobroker/iobroker-data: 745M /opt/iobroker/iobroker-data/ 328M /opt/iobroker/iobroker-data/history 239M /opt/iobroker/iobroker-data/files 124M /opt/iobroker/iobroker-data/backup-objects 57M /opt/iobroker/iobroker-data/files/javascript.admin The five largest files in iobroker-data are: 52M /opt/iobroker/iobroker-data/objects.jsonl 33M /opt/iobroker/iobroker-data/files/iot.admin/static/js/main.1797d034.js.map 22M /opt/iobroker/iobroker-data/files/web.admin/static/js/main.c05ba1d3.js.map 19M /opt/iobroker/iobroker-data/files/text2command.admin/static/js/main.02fc3820.js.map 8.9M /opt/iobroker/iobroker-data/files/scenes.admin/static/js/2.7de3299d.chunk.js.map USB-Devices by-id: USB-Sticks - Avoid direct links to /dev/* in your adapter setups, please always prefer the links 'by-id': /dev/serial/by-id/usb-ITead_Sonoff_Zigbee_3.0_USB_Dongle_Plus_323adb3b74d9eb11b6e6178e6fe9f4d9-if00-port0 *** NodeJS-Installation *** /usr/bin/nodejs v18.19.0 /usr/bin/node v18.19.0 /usr/bin/npm 10.2.3 /usr/bin/npx 10.2.3 /usr/bin/corepack 0.22.0 nodejs: Installed: 18.19.0-1nodesource1 Candidate: 18.19.1-1nodesource1 Version table: 18.19.1-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages *** 18.19.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 100 /var/lib/dpkg/status 18.18.2-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.18.1-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.18.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.17.1-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.17.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.16.1-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.16.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.15.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.14.2-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.14.1-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.14.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.13.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.12.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.11.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.10.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.9.1-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.9.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.8.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.7.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.6.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.5.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.4.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.3.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.2.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.1.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 18.0.0-1nodesource1 1001 500 https://deb.nodesource.com/node_18.x nodistro/main arm64 Packages 12.22.12~dfsg-1~deb11u4 500 500 http://deb.debian.org/debian bullseye/main arm64 Packages 500 http://security.debian.org/debian-security bullseye-security/main arm64 Packages Temp directories causing npm8 problem: 0 No problems detected Errors in npm tree: *** ioBroker-Installation *** ioBroker Status iobroker is running on this host. Objects type: jsonl States type: redis Core adapters versions js-controller: 5.0.17 admin: 6.13.16 javascript: 7.8.0 Adapters from github: 2 Adapter State system.adapter.adb.0 : adb : raspibull - disabled + system.adapter.admin.0 : admin : raspibull - enabled, port: 8081, bind: 0.0.0.0, run as: admin + system.adapter.alexa2.0 : alexa2 : raspibull - enabled + system.adapter.backitup.0 : backitup : raspibull - enabled system.adapter.broadlink2.0 : broadlink2 : raspibull - disabled system.adapter.daikin.0 : daikin : raspibull - disabled + system.adapter.daikin.1 : daikin : raspibull - enabled system.adapter.discovery.0 : discovery : raspibull - disabled + system.adapter.doorbird.0 : doorbird : raspibull - enabled + system.adapter.email.0 : email : raspibull - enabled + system.adapter.email.1 : email : raspibull - disabled system.adapter.flot.0 : flot : raspibull - disabled + system.adapter.fritzdect.0 : fritzdect : raspibull - enabled system.adapter.fullybrowser.0 : fullybrowser : raspibull - disabled + system.adapter.history.0 : history : raspibull - enabled + system.adapter.influxdb.0 : influxdb : raspibull - enabled, port: 8086 + system.adapter.iot.0 : iot : raspibull - enabled + system.adapter.iqontrol.0 : iqontrol : raspibull - enabled + system.adapter.javascript.0 : javascript : raspibull - enabled + system.adapter.lgtv.0 : lgtv : raspibull - enabled + system.adapter.mqtt.0 : mqtt : raspibull - enabled, port: 1883, bind: 0.0.0.0 + system.adapter.netatmo.0 : netatmo : raspibull - enabled + system.adapter.nuki-extended.0 : nuki-extended : raspibull - enabled + system.adapter.onkyo.0 : onkyo : raspibull - enabled system.adapter.onvif.0 : onvif : raspibull - disabled, port: 80, 7575, 8000, 8080, 8081, 8899 system.adapter.onvif.1 : onvif : raspibull - disabled, port: 80, 7575, 8000, 8080, 8081, 8899 system.adapter.ping.0 : ping : raspibull - disabled system.adapter.robonect.0 : robonect : raspibull - disabled + system.adapter.scenes.0 : scenes : raspibull - enabled + system.adapter.shelly.0 : shelly : raspibull - enabled, port: 1882, bind: 0.0.0.0 + system.adapter.shelly.1 : shelly : raspibull - enabled, port: 1882, bind: 0.0.0.0 + system.adapter.signal-cmb.0 : signal-cmb : raspibull - enabled + system.adapter.simple-api.0 : simple-api : raspibull - enabled, port: 8087, bind: 192.168.178.78, run as: admin + system.adapter.socketio.0 : socketio : raspibull - enabled, port: 8084, bind: 0.0.0.0, run as: admin + system.adapter.sonoff.0 : sonoff : raspibull - enabled, port: 1889, bind: 0.0.0.0 system.adapter.telegram.0 : telegram : raspibull - disabled, port: 8443, bind: 0.0.0.0 system.adapter.text2command.0 : text2command : raspibull - disabled + system.adapter.tr-064.0 : tr-064 : raspibull - enabled system.adapter.weatherunderground.0 : weatherunderground : raspibull - disabled + system.adapter.web.0 : web : raspibull - enabled, port: 8082, bind: 0.0.0.0, run as: admin + system.adapter.zigbee.0 : zigbee : raspibull - enabled, port: /dev/ttyUSB0 + instance is alive Enabled adapters with bindings + system.adapter.admin.0 : admin : raspibull - enabled, port: 8081, bind: 0.0.0.0, run as: admin + system.adapter.influxdb.0 : influxdb : raspibull - enabled, port: 8086 + system.adapter.mqtt.0 : mqtt : raspibull - enabled, port: 1883, bind: 0.0.0.0 + system.adapter.shelly.0 : shelly : raspibull - enabled, port: 1882, bind: 0.0.0.0 + system.adapter.shelly.1 : shelly : raspibull - enabled, port: 1882, bind: 0.0.0.0 + system.adapter.simple-api.0 : simple-api : raspibull - enabled, port: 8087, bind: 192.168.178.78, run as: admin + system.adapter.socketio.0 : socketio : raspibull - enabled, port: 8084, bind: 0.0.0.0, run as: admin + system.adapter.sonoff.0 : sonoff : raspibull - enabled, port: 1889, bind: 0.0.0.0 + system.adapter.web.0 : web : raspibull - enabled, port: 8082, bind: 0.0.0.0, run as: admin + system.adapter.zigbee.0 : zigbee : raspibull - enabled, port: /dev/ttyUSB0 ioBroker-Repositories stable : http://download.iobroker.net/sources-dist.json beta : http://download.iobroker.net/sources-dist-latest.json Active repo(s): stable Installed ioBroker-Instances Used repository: stable Adapter "adb" : 0.0.7 , installed 0.0.7 Adapter "admin" : 6.13.16 , installed 6.13.16 Adapter "alexa2" : 3.26.4 , installed 3.26.4 Adapter "backitup" : 2.10.11 , installed 2.10.11 Adapter "broadlink2" : 2.1.5 , installed 2.1.5 Adapter "daikin" : 1.4.2 , installed 1.4.2 Adapter "discovery" : 4.4.0 , installed 4.4.0 Adapter "doorbird" : 1.5.0 , installed 1.5.0 Adapter "email" : 1.2.2 , installed 1.2.2 Adapter "flot" : 1.12.0 , installed 1.12.0 Adapter "fritzdect" : 2.5.9 , installed 2.5.9 Adapter "fullybrowser" : 3.0.11 , installed 3.0.11 Adapter "history" : 3.0.1 , installed 3.0.1 Adapter "influxdb" : 4.0.2 , installed 4.0.2 Adapter "iot" : 2.0.11 , installed 2.0.11 Adapter "iqontrol" : 2.3.0 , installed 2.3.0 Adapter "javascript" : 7.8.0 , installed 7.8.0 Controller "js-controller": 5.0.19 , installed 5.0.17 [Updatable] Adapter "lgtv" : 2.1.2 , installed 2.1.2 Adapter "mqtt" : 5.2.0 , installed 5.2.0 Adapter "netatmo" : 3.1.0 , installed 3.1.0 Adapter "nuki-extended": 2.6.5 , installed 2.6.5 Adapter "onkyo" : 2.1.2 , installed 2.1.2 Adapter "onvif" : 1.1.2 , installed 1.1.2 Adapter "ping" : 1.6.2 , installed 1.6.2 Adapter "robonect" : 1.3.4 , installed 1.3.4 Adapter "scenes" : 2.3.9 , installed 2.3.9 Adapter "shelly" : 6.6.1 , installed 6.6.1 Adapter "signal-cmb" : 0.3.0 , installed 0.3.0 Adapter "simple-api" : 2.7.2 , installed 2.7.2 Adapter "socketio" : 6.6.0 , installed 6.6.0 Adapter "sonoff" : 3.0.3 , installed 3.0.3 Adapter "telegram" : 3.1.0 , installed 3.1.0 Adapter "text2command" : 3.0.3 , installed 3.0.3 Adapter "tr-064" : 4.2.18 , installed 4.2.18 Adapter "weatherunderground": 3.6.0, installed 3.6.0 Adapter "web" : 6.2.3 , installed 6.2.3 Adapter "ws" : 2.5.10 , installed 2.5.10 Adapter "zigbee" : 1.10.1 , installed 1.10.2 Objects and States Please stand by - This may take a while Objects: 11397 States: 7783 *** OS-Repositories and Updates *** W: GPG error: https://repos.influxdata.com/debian bullseye InRelease: The following signatures couldn't be verified because the public key is not available: NO_PUBKEY D8FF8E1F7DF8B07E E: The repository 'https://repos.influxdata.com/debian bullseye InRelease' is not signed. Pending Updates: 29 *** Listening Ports *** Active Internet connections (only servers) Proto Recv-Q Send-Q Local Address Foreign Address State User Inode PID/Program name tcp 0 0 127.0.0.1:5037 0.0.0.0:* LISTEN 1001 28118 3155/adb tcp 0 0 127.0.0.1:9001 0.0.0.0:* LISTEN 1001 14627 813/iobroker.js-con tcp 0 0 127.0.0.1:6379 0.0.0.0:* LISTEN 110 14474 537/redis-server 12 tcp 0 0 0.0.0.0:1883 0.0.0.0:* LISTEN 1001 14970 1364/io.mqtt.0 tcp 0 0 0.0.0.0:1882 0.0.0.0:* LISTEN 1001 16223 1552/io.shelly.1 tcp 0 0 0.0.0.0:1889 0.0.0.0:* LISTEN 1001 17579 1515/io.sonoff.0 tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN 0 15469 555/sshd: /usr/sbin tcp 0 0 127.0.0.1:8088 0.0.0.0:* LISTEN 999 14531 641/influxd tcp 0 0 192.168.178.78:8087 0.0.0.0:* LISTEN 1001 16715 1662/io.simple-api. tcp 0 0 192.168.178.78:8100 0.0.0.0:* LISTEN 1001 16206 1567/io.doorbird.0 tcp6 0 0 :::8081 :::* LISTEN 1001 16478 1283/io.admin.0 tcp6 0 0 :::8082 :::* LISTEN 1001 17845 1684/io.web.0 tcp6 0 0 :::8084 :::* LISTEN 1001 16739 1669/io.socketio.0 tcp6 0 0 :::8086 :::* LISTEN 999 14563 641/influxd tcp6 0 0 :::22 :::* LISTEN 0 15471 555/sshd: /usr/sbin tcp6 0 0 ::1:6379 :::* LISTEN 110 14475 537/redis-server 12 tcp6 0 0 :::51989 :::* LISTEN 1001 16103 1454/io.nuki-extend tcp6 0 0 :::3000 :::* LISTEN 111 14172 812/grafana udp 0 0 0.0.0.0:5683 0.0.0.0:* 1001 17558 1496/io.shelly.0 udp 0 0 0.0.0.0:68 0.0.0.0:* 0 14504 638/dhcpcd udp 0 0 0.0.0.0:60604 0.0.0.0:* 108 13941 429/avahi-daemon: r udp 0 0 0.0.0.0:5353 0.0.0.0:* 108 13939 429/avahi-daemon: r udp6 0 0 :::42951 :::* 108 13942 429/avahi-daemon: r udp6 0 0 :::546 :::* 0 10632 638/dhcpcd udp6 0 0 :::5353 :::* 108 13940 429/avahi-daemon: r *** Log File - Last 25 Lines *** 2024-03-20 10:53:55.618 - info: alexa2.0 (1389) Alexa-Push-Connection disconnected - retry: Retry Connection in 1s 2024-03-20 10:53:56.983 - info: alexa2.0 (1389) Alexa-Push-Connection (macDms = true) established. Disable Polling 2024-03-20 10:57:49.380 - info: javascript.0 (1184) script.js.Sensoren.Trockner: Zählerstand Strom: 30278.02 2024-03-20 11:13:13.998 - info: javascript.0 (1184) script.js.Sensoren.Proximity_Sensor_Echo: false 2024-03-20 11:16:38.446 - info: javascript.0 (1184) script.js.Sensoren.Proximity_Sensor_Echo: true 2024-03-20 11:30:54.450 - info: javascript.0 (1184) script.js.Sensoren.Trockner: Verbrauch (plug): 0.84 kWh 2024-03-20 11:30:54.451 - info: javascript.0 (1184) script.js.Sensoren.Trockner: totaler Verbrauch Zählerdifferenz: 0.9 kWh 2024-03-20 11:30:54.533 - info: signal-cmb.0 (1647) Send Karin der Trockner ist seit 11:30 fertig. to f98af11f-c3df-4b54-9f1e-0454df85f8bd 2024-03-20 11:39:52.301 - info: javascript.0 (1184) script.js.Sensoren.Doorbird_kill_ringing: request: http://ghewml0001:ENDdXvj9Yc@192.168.178.35/bha-api/audio-transmit.cgi 2024-03-20 11:39:52.301 - info: javascript.0 (1184) script.js.Sensoren.Doorbird_kill_ringing: doorbird ringing killed 2024-03-20 12:08:58.130 - info: javascript.0 (1184) script.js.Sensoren.Proximity_Sensor_Echo: false 2024-03-20 12:17:39.029 - info: javascript.0 (1184) script.js.Sensoren.Proximity_Sensor_Echo: true 2024-03-20 12:19:05.027 - info: javascript.0 (1184) script.js.Schalter.Automower_(mqtt): Statusende: 17 (Schläft), jetzt: Unbekannt 2024-03-20 12:19:06.005 - info: javascript.0 (1184) script.js.Schalter.Automower_(mqtt): Statusende: 0 (Bitte warten...), jetzt: Parken 2024-03-20 12:19:13.135 - info: javascript.0 (1184) script.js.Schalter.Automower_(mqtt): Statusende: 1 (Parkt), jetzt: Umsetzen 2024-03-20 12:19:24.357 - info: javascript.0 (1184) script.js.Schalter.Automower_(mqtt): Statusende: 5 (Suche), jetzt: Mähen 2024-03-20 12:58:46.949 - info: alexa2.0 (1389) Alexa-Push-Connection disconnected - retry: Retry Connection in 1s 2024-03-20 12:58:48.354 - info: alexa2.0 (1389) Alexa-Push-Connection (macDms = true) established. Disable Polling 2024-03-20 13:25:56.625 - info: javascript.0 (1184) script.js.Schalter.Test_Helligkeit: %%%%%%%%%%%%%%%%% Helligkeit geschaltet %%%%%%%%%%%% GSunsensor: 13787.705072715826 2024-03-20 13:26:04.005 - info: javascript.0 (1184) script.js.Schalter.Test_Helligkeit: %%%%%%%%%%%%%%%%% Helligkeit geschaltet %%%%%%%%%%%% GSunsensor: 13787.705072715826 2024-03-20 13:26:24.986 - info: javascript.0 (1184) script.js.Schalter.Test_Helligkeit: %%%%%%%%%%%%%%%%% Helligkeit geschaltet %%%%%%%%%%%% GSunsensor: 13787.705072715826 2024-03-20 14:30:01.622 - info: javascript.0 (1184) script.js.Schalter.Automower_(mqtt): Statusende: 2 (Mäht), jetzt: Parken 2024-03-20 14:30:01.623 - info: javascript.0 (1184) script.js.Schalter.Automower_(mqtt): Mähdauer: 130 Min. 2024-03-20 14:30:01.623 - info: javascript.0 (1184) script.js.Schalter.Automower_(mqtt): Battery charge: 0 % Battery voltage: 17.5 V 2024-03-20 14:30:10.701 - info: javascript.0 (1184) script.js.Schalter.Automower_(mqtt): Statusende: 1 (Parkt), jetzt: Suchen der Ladestationinfluxdb hatte ich auf debug, da immer wieder gewisse Werte mehrmahls abgespeichert werden mußten.
HUK -
@hukio sagte in IoBroker restart missglückt?:
4 orphan inodes deleted
Dateisystem beschädigt (wegen harter Stromtrennung)
@hukio sagte in IoBroker restart missglückt?:
/usr/bin/nodejs v18.19.0
nicht aktuell
@hukio sagte in IoBroker restart missglückt?:
Pending Updates: 29
naja, auch nicht aktuell
-
@hukio sagte in IoBroker restart missglückt?:
influxdb hatte ich auf debug, da immer wieder
Führt aber unter anderem zu einer erhöhten Logausgabe/Größe
Dein Backup Ordner ist ebenfalls mit 8Gb belegt
Simple API bind auf die IP?
Warum 2x shelly? -
Da es dir ohnehin in allernächster Zeit bevorsteht:
Installier das frisch NEU ein Raspberry OS 12 'Bookworm'. -
@crunchip
Habe update und upgrade gemacht. 2 Shelly, da die Mehrzahl unter Coap läuft und die neuen über mqtt müssen. Habe den backup Ordner aufgeräumt.
Danke
HUK -
@thomas-braun
Daran habe ich auch schon gedacht. Für mich doch einige Arbeit, da ja nicht nur IoBroker läuft, sondern auch andere Programme wie influxdb, grafana, ffmpeg, adb etc. Die müssen auch alle neu installiert werden. Ich kenne mich mit Linux nicht gut aus.
Ich frage mich, warum das System immer wieder abschmiert. Irgendwie habe ich den Eindruck, daß influxdb damit zusammenhängt (siehe das log vor dem crash).
Danke
HUK -
@hukio sagte in IoBroker restart missglückt?:
auch andere Programme wie influxdb, grafana, ffmpeg, adb etc.
Auf einem
@hukio sagte in IoBroker restart missglückt?:
Raspberry Pi 4 Model B Rev 1.1
mit
@hukio sagte in IoBroker restart missglückt?:
Mem: 3.8G
???
Meinst du nicht dass das ein kleines Stück zu viel für den kleinen sein könnte?
und 28 laufende +x scheduled Instanzen von ioBroker
-
@hukio sagte in IoBroker restart missglückt?:
influxdb, grafana, ffmpeg, adb etc.
läuft das alles auf Deinem RPI lokal ?
-
@djmarc75
ja (auf einer SSD) -
@hukio sagte in IoBroker restart missglückt?:
auf einer SSD
ist egal auf welchem Medium, wichtig ist der RAM und nicht der "Festplattenspeicher"
-
@hukio sagte in IoBroker restart missglückt?:
@djmarc75
ja (auf einer SSD)Da ist reichlich Platz,
Die Engstelle ist RAM, RAM und nochmal RAM -
@hukio sagte in IoBroker restart missglückt?:
da die Mehrzahl unter Coap läuft
Laut deiner Ausgabe läuft da Port 1882, also eigentlich mqtt
-
@hukio sagte in IoBroker restart missglückt?:
Für mich doch einige Arbeit,
Du kommst aber nicht drumherum.
Im Sommer ist Schicht für Bullseye.
Und auf Bookworm kann man nicht einfach per Dist-Upgrade gehen.Zusätzlich vermute ich, dass du da auch einfach viel zu viel Zeug auf die Kiste wirfst.
-
@thomas-braun
In der Zwischenzeit habe ich alles auf die ganz letzte Version gebracht außr dem js-controller wegen breaking news von 5.0.18.
Wie kommt es zu dem Zeitsprung im log um 9:21:16? Dann kommt der Fehler admin.0 already running (9:17:31) und das System haengt sich auf.2024-03-24 08:48:58.796 - info: javascript.0 (26346) script.js.Sensoren.Gasverbrauch: ^^^^^^^ Gasc start: 0 2024-03-24 08:52:22.715 - info: javascript.0 (26346) script.js.Sensoren.Gaszähler: 1711266742714 Start of heating: 08:48:57 Length of heating interval: 174.427 Zählerdifferenz: 0.18 Zähler: 13033.68 vZ0: 13033.5 Verbrauch: 3.72 m3/h vdeltamax: 10542 vdeltamin: 9984 timestamp:1711266712211 vtpre: 1711266712211 Wohnzimmer T: 19.4 vtstart: 1711266537784 Zählerstand: 13033.68 2024-03-24 08:54:48.260 - info: javascript.0 (26346) script.js.Sensoren.Heizung.Heizung_T_Wz: Temperatur Wz: 19.6 passed &&&upper&&& T limit: 19.6 2024-03-24 09:18:55.544 - info: javascript.0 (26346) script.js.Sensoren.Heizung.Heizung_T_Wz: Temperatur Wz: 19.4 under &&&lower&&& limit T: 19.4 2024-03-24 09:20:53.324 - info: javascript.0 (26346) script.js.Sensoren.Gasverbrauch: ^^^^^^^ Gasc start: 0 2024-03-24 09:21:15.147 - info: alexa2.0 (26369) Alexa-Push-Connection disconnected - retry: Retry Connection in 1s 2024-03-24 09:21:16.520 - info: alexa2.0 (26369) Alexa-Push-Connection (macDms = true) established. Disable Polling 2024-03-24 09:17:23.605 - info: host.raspibull iobroker.js-controller version 5.0.17 js-controller starting 2024-03-24 09:17:23.614 - info: host.raspibull Copyright (c) 2014-2023 bluefox, 2014 hobbyquaker 2024-03-24 09:17:23.615 - info: host.raspibull hostname: raspibull, node: v18.19.1 2024-03-24 09:17:23.617 - info: host.raspibull ip addresses: 192.168.178.78 2003:cf:9f25:b400:5f29:e17a:8220:14a1 fe80::ccc:2f5:c76b:81ed 192.168.178.99 2003:cf:9f25:b400:3af:f248:601a:a447 fe80::8f31:1fe9:478a:1454 2024-03-24 09:17:26.142 - info: host.raspibull connected to Objects and States 2024-03-24 09:17:26.184 - info: host.raspibull added notifications configuration of host 2024-03-24 09:17:27.653 - info: host.raspibull Delete state "system.host.raspibull.versions.nodeCurrent" 2024-03-24 09:17:27.751 - info: host.raspibull 41 instances found 2024-03-24 09:17:27.995 - info: host.raspibull starting 27 instances 2024-03-24 09:17:28.374 - info: host.raspibull Delete state "system.host.raspibull.versions.nodeNewest" 2024-03-24 09:17:28.407 - info: host.raspibull instance system.adapter.admin.0 started with pid 1063 2024-03-24 09:17:28.428 - info: host.raspibull Delete state "system.host.raspibull.versions.nodeNewestNext" 2024-03-24 09:17:28.439 - info: host.raspibull Delete state "system.host.raspibull.versions.npmCurrent" 2024-03-24 09:17:28.450 - info: host.raspibull Delete state "system.host.raspibull.versions.npmNewest" 2024-03-24 09:17:28.461 - info: host.raspibull Delete state "system.host.raspibull.versions.npmNewestNext" 2024-03-24 09:17:28.469 - info: host.raspibull Some obsolete host states deleted. 2024-03-24 09:17:31.419 - error: admin.0 (1063) admin.0 already running 2024-03-24 09:17:31.424 - warn: admin.0 (1063) Terminated (ADAPTER_ALREADY_RUNNING): Without reason 2024-03-24 09:17:32.558 - error: host.raspibull instance system.adapter.admin.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING) 2024-03-24 09:17:32.559 - info: host.raspibull Restart adapter system.adapter.admin.0 because enabled 2024-03-24 09:17:32.581 - info: host.raspibull instance system.adapter.email.0 started with pid 1081 2024-03-24 09:17:34.406 - error: email.0 (1081) email.0 already running 2024-03-24 09:17:34.411 - warn: email.0 (1081) Terminated (ADAPTER_ALREADY_RUNNING): Without reason 2024-03-24 09:17:35.215 - error: host.raspibull instance system.adapter.email.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING) 2024-03-24 09:17:35.217 - info: host.raspibull Restart adapter system.adapter.email.0 because enabled 2024-03-24 09:17:36.273 - info: host.raspibull instance system.adapter.history.0 started with pid 1092 2024-03-24 09:17:38.088 - error: history.0 (1092) history.0 already running 2024-03-24 09:17:38.093 - warn: history.0 (1092) Terminated (ADAPTER_ALREADY_RUNNING): Without reason 2024-03-24 09:29:23.922 - error: host.raspibull instance system.adapter.history.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING) 2024-03-24 09:29:23.922 - info: host.raspibull Restart adapter system.adapter.history.0 because enabled 2024-03-24 09:29:25.308 - info: host.raspibull instance system.adapter.influxdb.0 started with pid 1181 2024-03-24 09:29:28.171 - info: influxdb.0 (1181) starting. Version 4.0.2 in /opt/iobroker/node_modules/iobroker.influxdb, node: v18.19.1, js-controller: 5.0.17 2024-03-24 09:29:28.202 - info: influxdb.0 (1181) No stored data from last exit found 2024-03-24 09:29:28.204 - info: influxdb.0 (1181) Connecting http://localhost:8086/ ... 2024-03-24 09:29:28.206 - info: influxdb.0 (1181) Influx DB Version used: 1.x 2024-03-24 09:29:28.367 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d0001d7257f.humidity, Alias=false, 1 points now activated 2024-03-24 09:29:28.368 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d0001d7257f.temperature, Alias=false, 2 points now activated 2024-03-24 09:29:28.370 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d0002c903e6.humidity, Alias=false, 3 points now activated 2024-03-24 09:29:28.371 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d0002c903e6.temperature, Alias=false, 4 points now activated 2024-03-24 09:29:28.372 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d0002ca02cd.humidity, Alias=false, 5 points now activated 2024-03-24 09:29:28.372 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d0002ca02cd.temperature, Alias=false, 6 points now activated 2024-03-24 09:29:28.374 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d0002e99490.humidity, Alias=false, 7 points now activated 2024-03-24 09:29:28.375 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d0002e99490.temperature, Alias=false, 8 points now activated 2024-03-24 09:29:28.376 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d000589029b.humidity, Alias=false, 9 points now activated 2024-03-24 09:29:28.376 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d000589029b.temperature, Alias=false, 10 points now activated 2024-03-24 09:29:28.377 - info: influxdb.0 (1181) enabled logging of zigbee.0.842e14fffe1394aa.load_power, Alias=false, 11 points now activated 2024-03-24 09:29:28.378 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c13870c77b88bd.humidity, Alias=false, 12 points now activated 2024-03-24 09:29:28.379 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c13870c77b88bd.temperature, Alias=false, 13 points now activated 2024-03-24 09:29:28.380 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c138947e577a51.humidity, Alias=false, 14 points now activated 2024-03-24 09:29:28.381 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c138947e577a51.temperature, Alias=false, 15 points now activated 2024-03-24 09:29:28.382 - info: influxdb.0 (1181) enabled logging of sonoff.0.Stromzähler._Zählerstand, Alias=false, 16 points now activated 2024-03-24 09:29:28.382 - info: influxdb.0 (1181) enabled logging of javascript.0.gGasc, Alias=false, 17 points now activated 2024-03-24 09:29:28.383 - info: influxdb.0 (1181) enabled logging of javascript.0.gGasd, Alias=false, 18 points now activated 2024-03-24 09:29:28.384 - info: influxdb.0 (1181) enabled logging of javascript.0.gGash, Alias=false, 19 points now activated 2024-03-24 09:29:28.384 - info: influxdb.0 (1181) enabled logging of javascript.0.gStromc, Alias=false, 20 points now activated 2024-03-24 09:29:28.384 - info: influxdb.0 (1181) enabled logging of javascript.0.gStromd, Alias=false, 21 points now activated 2024-03-24 09:29:28.385 - info: influxdb.0 (1181) enabled logging of javascript.0.gStromh, Alias=false, 22 points now activated 2024-03-24 09:29:28.385 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c1387adb854200.temperature, Alias=false, 23 points now activated 2024-03-24 09:29:28.386 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c1387adb854200.humidity, Alias=false, 24 points now activated 2024-03-24 09:29:28.386 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c138e95e35c14d.temperature, Alias=false, 25 points now activated 2024-03-24 09:29:28.387 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c138e95e35c14d.humidity, Alias=false, 26 points now activated 2024-03-24 09:29:28.387 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c138bda9a48a36.temperature, Alias=false, 27 points now activated 2024-03-24 09:29:28.388 - info: influxdb.0 (1181) enabled logging of zigbee.0.a4c138bda9a48a36.humidity, Alias=false, 28 points now activated 2024-03-24 09:29:28.388 - info: influxdb.0 (1181) enabled logging of zigbee.0.048727fffec54ec6.temperature, Alias=false, 29 points now activated 2024-03-24 09:29:28.389 - info: influxdb.0 (1181) enabled logging of shelly.1.shellyplus1pm#fcb467279060#1.Relay0.Power, Alias=false, 30 points now activated 2024-03-24 09:29:28.389 - info: influxdb.0 (1181) enabled logging of javascript.0.gClimad, Alias=false, 31 points now activated 2024-03-24 09:29:28.390 - info: influxdb.0 (1181) enabled logging of javascript.0.gClimah, Alias=false, 32 points now activated 2024-03-24 09:29:28.390 - info: influxdb.0 (1181) enabled logging of shelly.1.shellyplusplugs#d4d4daebcba4#1.Relay0.Power, Alias=false, 33 points now activated 2024-03-24 09:29:28.391 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d000227f14a.temperature, Alias=false, 34 points now activated 2024-03-24 09:29:28.391 - info: influxdb.0 (1181) enabled logging of zigbee.0.00158d000227f14a.humidity, Alias=false, 35 points now activated 2024-03-24 09:29:29.393 - info: host.raspibull instance system.adapter.javascript.0 started with pid 1209 2024-03-24 09:29:33.322 - info: host.raspibull instance system.adapter.scenes.0 started with pid 1220 2024-03-24 09:29:33.526 - info: javascript.0 (1209) starting. Version 7.8.0 in /opt/iobroker/node_modules/iobroker.javascript, node: v18.19.1, js-controller: 5.0.17 2024-03-24 09:29:35.198 - info: javascript.0 (1209) requesting all states 2024-03-24 09:29:35.201 - info: javascript.0 (1209) requesting all objects 2024-03-24 09:29:36.488 - info: javascript.0 (1209) received all states 2024-03-24 09:29:37.605 - info: host.raspibull instance system.adapter.alexa2.0 started with pid 1235 2024-03-24 09:29:38.504 - info: scenes.0 (1220) starting. Version 2.3.9 in /opt/iobroker/node_modules/iobroker.scenes, node: v18.19.1, js-controller: 5.0.17 2024-03-24 09:29:38.779 - info: javascript.0 (1209) received all objects 2024-03-24 09:29:40.321 - info: javascript.0 (1209) Start javascript script.js.Abwesenheit.Abwesenheit_BewegungKönnte das Problem mit der Öffnung einer website des IoBroker zusammenhaengen? Der Abbruch geschieht zum wiederholten Male ungefaehr zu der Zeit, wenn ich von einem PC auf den IoBroker zugreife.
Ich plane einen RPI5 einzusetzen. Das wird aber noch einige Zeit in Anspruch nehmen.
Danke
HUK
