Home Assistant mit RaspberryMatic Add-on: HMIPServer kann HM-MOD-RPI-PCB nicht ansprechen

[benni123_]

Ich habe gerade nochmal ein Diff von unseren boot.logs gemacht.

Links: Benjamin, Rechts: Baxxy

Es scheint als würde HmIP korrekt gefunden, aber kein HmRF ...

[Baxxy]

Das meiste kann man man ignorieren, bzw. ist eine Folge des fehlenden "HmRF" vom Funkmodul.

Flashe doch mal eine normale RM für den Pi4B und boote diese.
Dann mal in die Hilfeseite gucken ob damit dein Funkmodul vollständig erkannt wird.

[benni123_]

Sehr gute Idee. Gerade RM geflasht. System bootet (grüne und rote LED blinken).

Die WebUI (Zugriff über Browser/IP) hing etwa 5 Minuten im Startbildschirm:

Eventuell gab es hier (wie auch im Home Assistant Add-on) einen Hänger bei HMIPServer?

Dann ging es aber weiter und ich konnte die Grundeinrichtung machen.

Hier die Hilfe-Seite:

Sehr interessant. Auch hier wird offensichtlich HmRF nicht erkannt (unten rechts) ...

Hier noch ein paar Logfiles:

Code: Alles auswählen

***** /var/log/boot.log *****
fsck 1.47.0 (5-Feb-2023)
userfs: clean, 13/376 files, 1192/3000 blocks
Starting watchdog...
Identifying host system: Raspberry Pi 4 Model B Rev 1.2 (rpi4), OK
Initializing ZRAM Swap: OK
Initializing RTC Clock: no hardware found
Running sysctl: OK
Checking for Factory Reset: mke2fs 1.47.0 (5-Feb-2023)
Discarding device blocks:       0/74640631572864/74640632621440/74640633670016/74640637340032/7464063               done                            
Creating filesystem with 7464063 4k blocks and 1867776 inodes
Filesystem UUID: e35cb493-557d-479a-8cf5-17c2ffbbede5
Superblock backups stored on blocks: 
	32768, 98304, 163840, 229376, 294912, 819200, 884736, 1605632, 2654208, 
	4096000

Allocating group tables:   0/228       done                            
Writing inode tables:   0/228  9/228 25/228 40/228 54/228 69/228 84/228 99/228113/228128/228144/228158/228174/228189/228204/228218/228       done                            
Creating journal (32768 blocks): done
Writing superblocks and filesystem accounting information:   0/228       done

tune2fs 1.47.0 (5-Feb-2023)
Setting maximal mount count to -1
Setting interval between checks to 0 seconds
userfs: 12/1867776 files (0.0% non-contiguous), 161797/7464063 blocks
cleared, OK
Checking for Backup Restore: not required
Running seedrng: OK
Initializing System: OK
Setup ca-certificates: OK
Starting logging: OK
Starting ArgonONE/FAN daemon: no hardware found
Starting PiDesktop daemon: no hardware found
Populating /dev using udev: done
Init onboard LEDs: init, OK
Starting irqbalance: OK
Starting system message bus: done
Starting iptables: OK
Starting bluetoothd: disabled
Starting network: eth0:... link up, dhcp, firewall, inet up, 192.168.1.7, wlan0: disabled, OK
Starting Network Interface Plugging Daemon: eth0 wlan0.
Starting chrony: OK
Identifying Homematic RF-Hardware: ....HmRF: n/a, HmIP: HM-MOD-RPI-PCB/GPIO@fe201000.serial, OK
Updating Homematic RF-Hardware: HM-MOD-RPI-PCB: 2.8.6, not necessary, OK
Starting hs485dLoader: disabled
Starting xinetd: OK
Starting eq3configd: OK
Starting lighttpd: creating new SSL cert... OK
Starting ser2net: disabled
Starting ssdpd: OK
Starting NUT services: disabled
Starting PIco UPS daemon: no hardware found
Starting PiUSV+ daemon: no hardware found
Starting StromPi2 UPS daemon: disabled
Starting S.USV daemon: no hardware found
Initializing Third-Party Addons: OK
Starting LGWFirmwareUpdate: ...OK
Setting LAN Gateway keys: OK
Starting hs485d: disabled
Starting multimacd: not required
Starting rfd: no BidCos-RF hardware found
Starting HMIPServer: .......................................................................................................................................................ERROR
Starting ReGaHss: .OK
Starting CloudMatic: OK
Starting NeoServer: OK
Starting Third-Party Addons: OK
Starting crond: OK
Setup onboard LEDs: booted, OK
Finished Boot: 3.75.6.20240316 (raspmatic_rpi4)

Code: Alles auswählen

***** /var/log/messages *****
Jan  1 01:00:34 localhost syslog.info syslogd started: BusyBox v1.36.1
Jan  1 01:00:34 localhost kern.notice kernel: klogd started: BusyBox v1.36.1 (2024-03-16 11:29:00 UTC)
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083]
Jan  1 01:00:34 localhost kern.notice kernel: [    0.000000] Linux version 6.1.73 (builder@b152b859d874) (aarch64-buildroot-linux-gnu-gcc.br_real (Buildroot -g6d18e07) 12.3.0, GNU ld (GNU Binutils) 2.40) #1 SMP PREEMPT Sat Mar 16 12:41:06 UTC 2024
Jan  1 01:00:34 localhost kern.notice kernel: [    0.000000] Kernel is locked down from Kernel configuration; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.notice kernel: [    0.000000] random: crng init done
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.2
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] efi: UEFI not found.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Reserved memory: created CMA memory pool at 0x000000002ac00000, size 64 MiB
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Zone ranges:
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000]   DMA      [mem 0x0000000000000000-0x000000003fffffff]
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000]   DMA32    [mem 0x0000000040000000-0x00000000fbffffff]
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000]   Normal   empty
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Movable zone start for each node
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Early memory node ranges
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000]   node   0: [mem 0x0000000000000000-0x000000003dffffff]
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] On node 0, zone DMA32: 8192 pages in unavailable ranges
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] On node 0, zone DMA32: 16384 pages in unavailable ranges
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] percpu: Embedded 28 pages/cpu s75176 r8192 d31320 u114688
Jan  1 01:00:34 localhost kern.debug kernel: [    0.000000] pcpu-alloc: s75176 r8192 d31320 u114688 alloc=28*4096
Jan  1 01:00:34 localhost kern.debug kernel: [    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Detected PIPT I-cache on CPU0
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] CPU features: detected: Spectre-v2
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] CPU features: detected: Spectre-v3a
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] CPU features: detected: Spectre-v4
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] CPU features: detected: Spectre-BHB
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] CPU features: kernel page table isolation forced ON by KASLR
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] CPU features: detected: Kernel page table isolation (KPTI)
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] CPU features: detected: ARM erratum 1742098
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] alternatives: applying boot alternatives
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1007872
Jan  1 01:00:34 localhost kern.notice kernel: [    0.000000] Kernel command line: dwc_otg.lpm_enable=0 sdhci_bcm2708.enable_llm=0 console=tty2 root=PARTUUID=deedbeef-02 ro rootfstype=ext4 fsck.repair=yes rootwait rootdelay=5 consoleblank=120 logo.nologo quiet loglevel=0 init_on_alloc=1 init_on_free=1 slab_nomerge iomem=relaxed net.ifnames=0 usb-storage.quirks=174c:55aa:u,2109:0715:u,152d:0578:u,152d:0579:u,152d:1561:u,174c:0829:u,14b0:0206:u,174c:225c:u,7825:a2a4:u,152d:0562:u  coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_headphones=0 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:71:F9:BC vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  empty
Jan  1 01:00:34 localhost kern.notice kernel: [    0.000000] Unknown kernel command line parameters "empty", will be passed to user space.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:on
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] mem auto-init: clearing system memory may take some time...
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] software IO TLB: area num 4.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] software IO TLB: mapped [mem 0x000000003a000000-0x000000003e000000] (64MB)
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Memory: 3854788K/4096000K available (14848K kernel code, 2078K rwdata, 4112K rodata, 4288K init, 1353K bss, 175676K reserved, 65536K cma-reserved)
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] ftrace: allocating 40833 entries in 160 pages
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] ftrace: allocated 160 pages with 2 groups
Jan  1 01:00:34 localhost kern.notice kernel: [    0.000000] Lockdown: swapper: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.000000] Tracing disabled due to lockdown
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] rcu: Preemptible hierarchical RCU implementation.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] rcu: 	RCU event tracing is enabled.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] 	Trampoline variant of Tasks RCU enabled.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] 	Rude variant of Tasks RCU enabled.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] 	Tracing variant of Tasks RCU enabled.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] Root IRQ handler: gic_handle_irq
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] GIC: Using split EOI/Deactivate mode
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
Jan  1 01:00:34 localhost kern.info kernel: [    0.000000] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
Jan  1 01:00:34 localhost kern.info kernel: [    0.000327] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
Jan  1 01:00:34 localhost kern.info kernel: [    0.000477] Console: colour dummy device 80x25
Jan  1 01:00:34 localhost kern.info kernel: [    0.000534] printk: console [tty2] enabled
Jan  1 01:00:34 localhost kern.info kernel: [    0.000576] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000)
Jan  1 01:00:34 localhost kern.info kernel: [    0.000594] pid_max: default: 32768 minimum: 301
Jan  1 01:00:34 localhost kern.info kernel: [    0.000738] LSM: Security Framework initializing
Jan  1 01:00:34 localhost kern.info kernel: [    0.000801] landlock: Up and running.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000807] Yama: becoming mindful.
Jan  1 01:00:34 localhost kern.info kernel: [    0.000911] AppArmor: AppArmor initialized
Jan  1 01:00:34 localhost kern.info kernel: [    0.001057] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.001076] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.002040] cgroup: Disabling memory control group subsystem
Jan  1 01:00:34 localhost kern.info kernel: [    0.003580] cblist_init_generic: Setting adjustable number of callback queues.
Jan  1 01:00:34 localhost kern.info kernel: [    0.003594] cblist_init_generic: Setting shift to 2 and lim to 1.
Jan  1 01:00:34 localhost kern.info kernel: [    0.003705] cblist_init_generic: Setting adjustable number of callback queues.
Jan  1 01:00:34 localhost kern.info kernel: [    0.003715] cblist_init_generic: Setting shift to 2 and lim to 1.
Jan  1 01:00:34 localhost kern.info kernel: [    0.003831] cblist_init_generic: Setting adjustable number of callback queues.
Jan  1 01:00:34 localhost kern.info kernel: [    0.003840] cblist_init_generic: Setting shift to 2 and lim to 1.
Jan  1 01:00:34 localhost kern.info kernel: [    0.004131] rcu: Hierarchical SRCU implementation.
Jan  1 01:00:34 localhost kern.info kernel: [    0.004140] rcu: 	Max phase no-delay instances is 1000.
Jan  1 01:00:34 localhost kern.info kernel: [    0.005892] EFI services will not be available.
Jan  1 01:00:34 localhost kern.info kernel: [    0.006235] smp: Bringing up secondary CPUs ...
Jan  1 01:00:34 localhost kern.info kernel: [    0.006842] Detected PIPT I-cache on CPU1
Jan  1 01:00:34 localhost kern.info kernel: [    0.007001] CPU1: Booted secondary processor 0x0000000001 [0x410fd083]
Jan  1 01:00:34 localhost kern.info kernel: [    0.007688] Detected PIPT I-cache on CPU2
Jan  1 01:00:34 localhost kern.info kernel: [    0.007813] CPU2: Booted secondary processor 0x0000000002 [0x410fd083]
Jan  1 01:00:34 localhost kern.info kernel: [    0.008496] Detected PIPT I-cache on CPU3
Jan  1 01:00:34 localhost kern.info kernel: [    0.008626] CPU3: Booted secondary processor 0x0000000003 [0x410fd083]
Jan  1 01:00:34 localhost kern.info kernel: [    0.008719] smp: Brought up 1 node, 4 CPUs
Jan  1 01:00:34 localhost kern.info kernel: [    0.008737] SMP: Total of 4 processors activated.
Jan  1 01:00:34 localhost kern.info kernel: [    0.008745] CPU features: detected: 32-bit EL0 Support
Jan  1 01:00:34 localhost kern.info kernel: [    0.008753] CPU features: detected: CRC32 instructions
Jan  1 01:00:34 localhost kern.info kernel: [    0.008852] CPU features: emulated: Privileged Access Never (PAN) using TTBR0_EL1 switching
Jan  1 01:00:34 localhost kern.info kernel: [    0.008863] CPU: All CPU(s) started at EL2
Jan  1 01:00:34 localhost kern.info kernel: [    0.008869] alternatives: applying system-wide alternatives
Jan  1 01:00:34 localhost kern.info kernel: [    0.010801] devtmpfs: initialized
Jan  1 01:00:34 localhost kern.notice kernel: [    0.021787] Enabled cp15_barrier support
Jan  1 01:00:34 localhost kern.notice kernel: [    0.021817] Enabled setend support
Jan  1 01:00:34 localhost kern.info kernel: [    0.021964] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
Jan  1 01:00:34 localhost kern.info kernel: [    0.021991] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Jan  1 01:00:34 localhost kern.notice kernel: [    0.022091] Lockdown: swapper/0: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.022099] Can not register tracer wakeup due to lockdown
Jan  1 01:00:34 localhost kern.notice kernel: [    0.022111] Lockdown: swapper/0: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.022118] Can not register tracer function_graph due to lockdown
Jan  1 01:00:34 localhost kern.info kernel: [    0.053926] pinctrl core: initialized pinctrl subsystem
Jan  1 01:00:34 localhost kern.info kernel: [    0.054607] DMI not present or invalid.
Jan  1 01:00:34 localhost kern.info kernel: [    0.055103] NET: Registered PF_NETLINK/PF_ROUTE protocol family
Jan  1 01:00:34 localhost kern.info kernel: [    0.058851] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations
Jan  1 01:00:34 localhost kern.info kernel: [    0.059154] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
Jan  1 01:00:34 localhost kern.info kernel: [    0.060147] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
Jan  1 01:00:34 localhost kern.info kernel: [    0.060256] audit: initializing netlink subsys (disabled)
Jan  1 01:00:34 localhost kern.notice kernel: [    0.060496] audit: type=2000 audit(0.060:1): state=initialized audit_enabled=0 res=1
Jan  1 01:00:34 localhost kern.info kernel: [    0.061024] thermal_sys: Registered thermal governor 'step_wise'
Jan  1 01:00:34 localhost kern.info kernel: [    0.061088] cpuidle: using governor menu
Jan  1 01:00:34 localhost kern.info kernel: [    0.061715] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
Jan  1 01:00:34 localhost kern.info kernel: [    0.061852] ASID allocator initialised with 32768 entries
Jan  1 01:00:34 localhost kern.info kernel: [    0.069262] bcm2835-mbox fe00b880.mailbox: mailbox enabled
Jan  1 01:00:34 localhost kern.info kernel: [    0.080185] raspberrypi-firmware soc:firmware: Attached to firmware from 2023-10-17T15:39:16, variant start
Jan  1 01:00:34 localhost kern.info kernel: [    0.084198] raspberrypi-firmware soc:firmware: Firmware hash is 30f0c5e4d076da3ab4f341d88e7d505760b93ad7
Jan  1 01:00:34 localhost kern.info kernel: [    0.094021] KASLR enabled
Jan  1 01:00:34 localhost kern.info kernel: [    0.119267] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
Jan  1 01:00:34 localhost kern.info kernel: [    0.122190] iommu: Default domain type: Translated 
Jan  1 01:00:34 localhost kern.info kernel: [    0.122204] iommu: DMA domain TLB invalidation policy: strict mode 
Jan  1 01:00:34 localhost kern.notice kernel: [    0.122590] SCSI subsystem initialized
Jan  1 01:00:34 localhost kern.info kernel: [    0.122776] usbcore: registered new interface driver usbfs
Jan  1 01:00:34 localhost kern.info kernel: [    0.122826] usbcore: registered new interface driver hub
Jan  1 01:00:34 localhost kern.info kernel: [    0.122866] usbcore: registered new device driver usb
Jan  1 01:00:34 localhost kern.warn kernel: [    0.123030] usb_phy_generic phy: supply vcc not found, using dummy regulator
Jan  1 01:00:34 localhost kern.info kernel: [    0.123371] pps_core: LinuxPPS API ver. 1 registered
Jan  1 01:00:34 localhost kern.info kernel: [    0.123381] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Jan  1 01:00:34 localhost kern.info kernel: [    0.123401] PTP clock support registered
Jan  1 01:00:34 localhost kern.info kernel: [    0.124445] vgaarb: loaded
Jan  1 01:00:34 localhost kern.info kernel: [    0.125293] clocksource: Switched to clocksource arch_sys_counter
Jan  1 01:00:34 localhost kern.notice kernel: [    0.125309] Lockdown: swapper/0: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.125317] Tracing disabled due to lockdown
Jan  1 01:00:34 localhost kern.notice kernel: [    0.125323] Lockdown: swapper/0: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.125330] Tracing disabled due to lockdown
Jan  1 01:00:34 localhost kern.notice kernel: [    0.125342] Lockdown: swapper/0: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.125348] Tracing disabled due to lockdown
Jan  1 01:00:34 localhost kern.notice kernel: [    0.125357] Lockdown: swapper/0: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.125363] Tracing disabled due to lockdown
Jan  1 01:00:34 localhost kern.notice kernel: [    0.125370] Lockdown: swapper/0: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.125376] Tracing disabled due to lockdown
Jan  1 01:00:34 localhost kern.notice kernel: [    0.125725] VFS: Disk quotas dquot_6.6.0
Jan  1 01:00:34 localhost kern.info kernel: [    0.125779] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Jan  1 01:00:34 localhost kern.notice kernel: [    0.125877] FS-Cache: Loaded
Jan  1 01:00:34 localhost kern.info kernel: [    0.126034] CacheFiles: Loaded
Jan  1 01:00:34 localhost kern.info kernel: [    0.126537] AppArmor: AppArmor Filesystem Enabled
Jan  1 01:00:34 localhost kern.info kernel: [    0.135596] NET: Registered PF_INET protocol family
Jan  1 01:00:34 localhost kern.info kernel: [    0.135739] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.140619] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.140676] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.140716] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.140906] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.141946] TCP: Hash tables configured (established 32768 bind 32768)
Jan  1 01:00:34 localhost kern.info kernel: [    0.142277] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.142460] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.142512] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
Jan  1 01:00:34 localhost kern.info kernel: [    0.142755] NET: Registered PF_UNIX/PF_LOCAL protocol family
Jan  1 01:00:34 localhost kern.info kernel: [    0.143432] RPC: Registered named UNIX socket transport module.
Jan  1 01:00:34 localhost kern.info kernel: [    0.143444] RPC: Registered udp transport module.
Jan  1 01:00:34 localhost kern.info kernel: [    0.143450] RPC: Registered tcp transport module.
Jan  1 01:00:34 localhost kern.info kernel: [    0.143456] RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan  1 01:00:34 localhost kern.info kernel: [    0.143470] PCI: CLS 0 bytes, default 64
Jan  1 01:00:34 localhost kern.info kernel: [    0.145707] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
Jan  1 01:00:34 localhost kern.notice kernel: [    0.146741] Lockdown: swapper/0: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.146753] Tracing disabled due to lockdown
Jan  1 01:00:34 localhost kern.notice kernel: [    0.146762] Lockdown: swapper/0: use of tracefs is restricted; see man kernel_lockdown.7
Jan  1 01:00:34 localhost kern.warn kernel: [    0.146768] Can not register tracer blk due to lockdown
Jan  1 01:00:34 localhost kern.warn kernel: [    0.146775] blktrace: Warning: could not register the block tracer
Jan  1 01:00:34 localhost kern.notice kernel: [    0.147096] Initialise system trusted keyrings
Jan  1 01:00:34 localhost kern.info kernel: [    0.147337] workingset: timestamp_bits=46 max_order=20 bucket_order=0
Jan  1 01:00:34 localhost kern.notice kernel: [    0.158960] NFS: Registering the id_resolver key type
Jan  1 01:00:34 localhost kern.notice kernel: [    0.159003] Key type id_resolver registered
Jan  1 01:00:34 localhost kern.notice kernel: [    0.159010] Key type id_legacy registered
Jan  1 01:00:34 localhost kern.info kernel: [    0.159116] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Jan  1 01:00:34 localhost kern.info kernel: [    0.159137] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
Jan  1 01:00:34 localhost kern.info kernel: [    0.159174] ntfs: driver 2.1.32 [Flags: R/W].
Jan  1 01:00:34 localhost kern.notice kernel: [    0.161392] Key type asymmetric registered
Jan  1 01:00:34 localhost kern.notice kernel: [    0.161406] Asymmetric key parser 'x509' registered
Jan  1 01:00:34 localhost kern.info kernel: [    0.161481] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
Jan  1 01:00:34 localhost kern.info kernel: [    0.161719] io scheduler mq-deadline registered
Jan  1 01:00:34 localhost kern.info kernel: [    0.161731] io scheduler kyber registered
Jan  1 01:00:34 localhost kern.info kernel: [    0.167290] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
Jan  1 01:00:34 localhost kern.info kernel: [    0.167325] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
Jan  1 01:00:34 localhost kern.info kernel: [    0.167366] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
Jan  1 01:00:34 localhost kern.info kernel: [    0.167403] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
Jan  1 01:00:34 localhost kern.info kernel: [    0.167913] brcm-pcie fd500000.pcie: setting SCB_ACCESS_EN, READ_UR_MODE, MAX_BURST_SIZE
Jan  1 01:00:34 localhost kern.info kernel: [    0.168235] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
Jan  1 01:00:34 localhost kern.info kernel: [    0.168252] pci_bus 0000:00: root bus resource [bus 00-ff]
Jan  1 01:00:34 localhost kern.info kernel: [    0.168267] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
Jan  1 01:00:34 localhost kern.info kernel: [    0.168312] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
Jan  1 01:00:34 localhost kern.info kernel: [    0.168400] pci 0000:00:00.0: PME# supported from D0 D3hot
Jan  1 01:00:34 localhost kern.warn kernel: [    0.172248] pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator
Jan  1 01:00:34 localhost kern.warn kernel: [    0.172387] pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator
Jan  1 01:00:34 localhost kern.warn kernel: [    0.172445] pci_bus 0000:01: supply vpcie12v not found, using dummy regulator
Jan  1 01:00:34 localhost kern.info kernel: [    0.279381] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
Jan  1 01:00:34 localhost kern.info kernel: [    0.279561] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
Jan  1 01:00:34 localhost kern.info kernel: [    0.279654] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
Jan  1 01:00:34 localhost kern.info kernel: [    0.279936] pci 0000:01:00.0: PME# supported from D0 D3cold
Jan  1 01:00:34 localhost kern.info kernel: [    0.289402] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
Jan  1 01:00:34 localhost kern.info kernel: [    0.289425] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
Jan  1 01:00:34 localhost kern.info kernel: [    0.289486] pci 0000:00:00.0: PCI bridge to [bus 01]
Jan  1 01:00:34 localhost kern.info kernel: [    0.289498] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
Jan  1 01:00:34 localhost kern.info kernel: [    0.289722] pcieport 0000:00:00.0: enabling device (0000 -> 0002)
Jan  1 01:00:34 localhost kern.info kernel: [    0.289868] pcieport 0000:00:00.0: PME: Signaling with IRQ 30
Jan  1 01:00:34 localhost kern.info kernel: [    0.290175] pcieport 0000:00:00.0: AER: enabled with IRQ 30
Jan  1 01:00:34 localhost kern.info kernel: [    0.290922] simple-framebuffer 3ea9b000.framebuffer: framebuffer at 0x3ea9b000, 0x12c000 bytes
Jan  1 01:00:34 localhost kern.info kernel: [    0.290938] simple-framebuffer 3ea9b000.framebuffer: format=a8r8g8b8, mode=640x480x32, linelength=2560
Jan  1 01:00:34 localhost kern.info kernel: [    0.291365] Console: switching to colour frame buffer device 80x30
Jan  1 01:00:34 localhost kern.info kernel: [    0.292650] simple-framebuffer 3ea9b000.framebuffer: fb0: simplefb registered!
Jan  1 01:00:34 localhost kern.info kernel: [    0.297084] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
Jan  1 01:00:34 localhost kern.info kernel: [    0.298826] iproc-rng200 fe104000.rng: hwrng registered
Jan  1 01:00:34 localhost kern.info kernel: [    0.299060] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Jan  1 01:00:34 localhost kern.info kernel: [    0.309708] brd: module loaded
Jan  1 01:00:34 localhost kern.info kernel: [    0.315873] loop: module loaded
Jan  1 01:00:34 localhost kern.info kernel: [    0.316367] zram: Added device: zram0
Jan  1 01:00:34 localhost kern.info kernel: [    0.316942] Loading iSCSI transport class v2.0-870.
Jan  1 01:00:34 localhost kern.info kernel: [    0.320253] tun: Universal TUN/TAP device driver, 1.6
Jan  1 01:00:34 localhost kern.info kernel: [    0.321187] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
Jan  1 01:00:34 localhost kern.info kernel: [    0.421413] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
Jan  1 01:00:34 localhost kern.info kernel: [    0.423626] xhci_hcd 0000:01:00.0: enabling device (0000 -> 0002)
Jan  1 01:00:34 localhost kern.info kernel: [    0.423701] xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan  1 01:00:34 localhost kern.info kernel: [    0.423730] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
Jan  1 01:00:34 localhost kern.info kernel: [    0.424287] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0b00040000000890
Jan  1 01:00:34 localhost kern.info kernel: [    0.424764] xhci_hcd 0000:01:00.0: xHCI Host Controller
Jan  1 01:00:34 localhost kern.info kernel: [    0.424785] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
Jan  1 01:00:34 localhost kern.info kernel: [    0.424802] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
Jan  1 01:00:34 localhost kern.info kernel: [    0.425050] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
Jan  1 01:00:34 localhost kern.info kernel: [    0.425068] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 01:00:34 localhost kern.info kernel: [    0.425079] usb usb1: Product: xHCI Host Controller
Jan  1 01:00:34 localhost kern.info kernel: [    0.425089] usb usb1: Manufacturer: Linux 6.1.73 xhci-hcd
Jan  1 01:00:34 localhost kern.info kernel: [    0.425098] usb usb1: SerialNumber: 0000:01:00.0
Jan  1 01:00:34 localhost kern.info kernel: [    0.425663] hub 1-0:1.0: USB hub found
Jan  1 01:00:34 localhost kern.info kernel: [    0.425737] hub 1-0:1.0: 1 port detected
Jan  1 01:00:34 localhost kern.info kernel: [    0.426399] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01
Jan  1 01:00:34 localhost kern.info kernel: [    0.426415] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan  1 01:00:34 localhost kern.info kernel: [    0.426426] usb usb2: Product: xHCI Host Controller
Jan  1 01:00:34 localhost kern.info kernel: [    0.426436] usb usb2: Manufacturer: Linux 6.1.73 xhci-hcd
Jan  1 01:00:34 localhost kern.info kernel: [    0.426444] usb usb2: SerialNumber: 0000:01:00.0
Jan  1 01:00:34 localhost kern.info kernel: [    0.426936] hub 2-0:1.0: USB hub found
Jan  1 01:00:34 localhost kern.info kernel: [    0.426988] hub 2-0:1.0: 4 ports detected
Jan  1 01:00:34 localhost kern.info kernel: [    0.428049] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Jan  1 01:00:34 localhost kern.debug kernel: [    0.428157] dwc_otg: FIQ enabled
Jan  1 01:00:34 localhost kern.debug kernel: [    0.428164] dwc_otg: NAK holdoff enabled
Jan  1 01:00:34 localhost kern.debug kernel: [    0.428170] dwc_otg: FIQ split-transaction FSM enabled
Jan  1 01:00:34 localhost kern.debug kernel: [    0.428180] Module dwc_common_port init
Jan  1 01:00:34 localhost kern.info kernel: [    0.428837] usbcore: registered new interface driver uas
Jan  1 01:00:34 localhost kern.info kernel: [    0.428914] usbcore: registered new interface driver usb-storage
Jan  1 01:00:34 localhost kern.info kernel: [    0.429009] usbcore: registered new interface driver usbserial_generic
Jan  1 01:00:34 localhost kern.info kernel: [    0.429037] usbserial: USB Serial support registered for generic
Jan  1 01:00:34 localhost kern.info kernel: [    0.429472] Driver for 1-wire Dallas network protocol.
Jan  1 01:00:34 localhost kern.info kernel: [    0.430797] device-mapper: ioctl: 4.47.0-ioctl (2022-07-28) initialised: dm-devel@redhat.com
Jan  1 01:00:34 localhost kern.info kernel: [    0.433031] sdhci: Secure Digital Host Controller Interface driver
Jan  1 01:00:34 localhost kern.info kernel: [    0.433045] sdhci: Copyright(c) Pierre Ossman
Jan  1 01:00:34 localhost kern.err kernel: [    0.433249] Error: Driver 'sdhost-bcm2835' is already registered, aborting...
Jan  1 01:00:34 localhost kern.info kernel: [    0.433258] sdhci-pltfm: SDHCI platform and OF driver helper
Jan  1 01:00:34 localhost kern.info kernel: [    0.436576] ledtrig-cpu: registered to indicate activity on CPUs
Jan  1 01:00:34 localhost kern.info kernel: [    0.436675] hid: raw HID events driver (C) Jiri Kosina
Jan  1 01:00:34 localhost kern.info kernel: [    0.436818] usbcore: registered new interface driver usbhid
Jan  1 01:00:34 localhost kern.info kernel: [    0.436822] usbhid: USB HID core driver
Jan  1 01:00:34 localhost kern.info kernel: [    0.442456] NET: Registered PF_INET6 protocol family
Jan  1 01:00:34 localhost kern.info kernel: [    0.443279] Segment Routing with IPv6
Jan  1 01:00:34 localhost kern.info kernel: [    0.443299] In-situ OAM (IOAM) with IPv6
Jan  1 01:00:34 localhost kern.info kernel: [    0.443381] NET: Registered PF_PACKET protocol family
Jan  1 01:00:34 localhost kern.info kernel: [    0.443428] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Jan  1 01:00:34 localhost kern.notice kernel: [    0.443478] Key type dns_resolver registered
Jan  1 01:00:34 localhost kern.info kernel: [    0.444163] registered taskstats version 1
Jan  1 01:00:34 localhost kern.notice kernel: [    0.444196] Loading compiled-in X.509 certificates
Jan  1 01:00:34 localhost kern.notice kernel: [    0.446405] Loaded X.509 cert 'Build time autogenerated kernel key: c62db4b3a5b1783de6b17d82c07d95988e324b19'
Jan  1 01:00:34 localhost kern.notice kernel: [    0.446632] Key type .fscrypt registered
Jan  1 01:00:34 localhost kern.notice kernel: [    0.446638] Key type fscrypt-provisioning registered
Jan  1 01:00:34 localhost kern.info kernel: [    0.446764] AppArmor: AppArmor sha1 policy hashing enabled
Jan  1 01:00:34 localhost kern.info kernel: [    0.457759] fe215040.serial: ttyS0 at MMIO 0xfe215040 (irq = 35, base_baud = 62500000) is a 16550
Jan  1 01:00:34 localhost kern.info kernel: [    0.458325] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Jan  1 01:00:34 localhost kern.info kernel: [    0.458453] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Jan  1 01:00:34 localhost kern.info kernel: [    0.458858] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0
Jan  1 01:00:34 localhost kern.info kernel: [    0.458865] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated
Jan  1 01:00:34 localhost kern.info kernel: [    0.483922] of_cfs_init
Jan  1 01:00:34 localhost kern.info kernel: [    0.484066] of_cfs_init: OK
Jan  1 01:00:34 localhost kern.info kernel: [    0.485182] Waiting 5 sec before mounting root device...
Jan  1 01:00:34 localhost kern.info kernel: [    0.521363] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
Jan  1 01:00:34 localhost kern.info kernel: [    0.562712] mmc1: new high speed SDIO card at address 0001
Jan  1 01:00:34 localhost kern.info kernel: [    0.621792] mmc0: new ultra high speed DDR50 SDHC card at address aaaa
Jan  1 01:00:34 localhost kern.info kernel: [    0.622229] mmcblk0: mmc0:aaaa SH32G 29.7 GiB 
Jan  1 01:00:34 localhost kern.info kernel: [    0.623841]  mmcblk0: p1 p2 p3
Jan  1 01:00:34 localhost kern.info kernel: [    0.624166] mmcblk0: mmc0:aaaa SH32G 29.7 GiB (quirks 0x00004000)
Jan  1 01:00:34 localhost kern.info kernel: [    0.681311] usb 1-1: new high-speed USB device number 2 using xhci_hcd
Jan  1 01:00:34 localhost kern.info kernel: [    0.831960] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
Jan  1 01:00:34 localhost kern.info kernel: [    0.831980] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Jan  1 01:00:34 localhost kern.info kernel: [    0.831992] usb 1-1: Product: USB2.0 Hub
Jan  1 01:00:34 localhost kern.info kernel: [    0.833436] hub 1-1:1.0: USB hub found
Jan  1 01:00:34 localhost kern.info kernel: [    0.833698] hub 1-1:1.0: 4 ports detected
Jan  1 01:00:34 localhost kern.info kernel: [    1.129330] usb 1-1.3: new full-speed USB device number 3 using xhci_hcd
Jan  1 01:00:34 localhost kern.info kernel: [    1.238461] usb 1-1.3: New USB device found, idVendor=1cf1, idProduct=0030, bcdDevice= 1.00
Jan  1 01:00:34 localhost kern.info kernel: [    1.238479] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jan  1 01:00:34 localhost kern.info kernel: [    1.238491] usb 1-1.3: Product: ConBee II
Jan  1 01:00:34 localhost kern.info kernel: [    1.238501] usb 1-1.3: Manufacturer: dresden elektronik ingenieurtechnik GmbH
Jan  1 01:00:34 localhost kern.info kernel: [    1.238510] usb 1-1.3: SerialNumber: DE2193845
Jan  1 01:00:34 localhost kern.info kernel: [    5.630561] EXT4-fs (mmcblk0p2): orphan cleanup on readonly fs
Jan  1 01:00:34 localhost kern.info kernel: [    5.630925] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none.
Jan  1 01:00:34 localhost kern.info kernel: [    5.631001] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Jan  1 01:00:34 localhost kern.info kernel: [    5.631522] devtmpfs: mounted
Jan  1 01:00:34 localhost kern.info kernel: [    5.639266] Freeing unused kernel memory: 4288K
Jan  1 01:00:34 localhost kern.info kernel: [    5.679383] Checked W+X mappings: passed, no W+X pages found
Jan  1 01:00:34 localhost kern.info kernel: [    5.679415] Run /sbin/init as init process
Jan  1 01:00:34 localhost kern.debug kernel: [    5.679419]   with arguments:
Jan  1 01:00:34 localhost kern.debug kernel: [    5.679421]     /sbin/init
Jan  1 01:00:34 localhost kern.debug kernel: [    5.679423]     empty
Jan  1 01:00:34 localhost kern.debug kernel: [    5.679426]   with environment:
Jan  1 01:00:34 localhost kern.debug kernel: [    5.679428]     HOME=/
Jan  1 01:00:34 localhost kern.debug kernel: [    5.679430]     TERM=linux
Jan  1 01:00:34 localhost kern.err kernel: [    6.005016] EXT4-fs: Mount option(s) incompatible with ext2
Jan  1 01:00:34 localhost kern.info kernel: [    6.018243] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none.
Jan  1 01:00:34 localhost kern.info kernel: [    7.003296] zram: Added device: zram1
Jan  1 01:00:34 localhost kern.info kernel: [    7.005883] zram1: detected capacity change from 0 to 8241688
Jan  1 01:00:34 localhost kern.info kernel: [    7.030495] Adding 4120840k swap on /dev/zram1.  Priority:75 extents:1 across:4120840k SS
Jan  1 01:00:34 localhost kern.info kernel: [    7.082662] i2c_dev: i2c /dev entries driver
Jan  1 01:00:34 localhost kern.info kernel: [    7.272995] EXT4-fs (mmcblk0p3): unmounting filesystem.
Jan  1 01:00:34 localhost kern.err kernel: [   31.977428] EXT4-fs: Mount option(s) incompatible with ext2
Jan  1 01:00:34 localhost kern.info kernel: [   32.255441] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none.
Jan  1 01:00:34 localhost daemon.info kernel: [   34.441357] udevd[1087]: starting version 3.2.14
Jan  1 01:00:34 localhost daemon.info kernel: [   34.479024] udevd[1088]: starting eudev-3.2.14
Jan  1 01:00:34 localhost kern.info kernel: [   34.659853] rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000
Jan  1 01:00:34 localhost kern.info kernel: [   34.662720] rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem
Jan  1 01:00:34 localhost kern.warn kernel: [   34.664579] generic_raw_uart: loading out-of-tree module taints kernel.
Jan  1 01:00:34 localhost kern.warn kernel: [   34.673630] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Jan  1 01:00:34 localhost kern.info kernel: [   34.675855] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Jan  1 01:00:34 localhost kern.info kernel: [   34.675874] [vc_sm_connected_init]: start
Jan  1 01:00:34 localhost kern.info kernel: [   34.676227] [vc_sm_connected_init]: installed successfully
Jan  1 01:00:34 localhost kern.info kernel: [   34.682986] pl011_raw_uart fe201000.serial: there is not valid maps for state default
Jan  1 01:00:34 localhost kern.info kernel: [   34.683353] pl011_raw_uart fe201000.serial: Initialized pl011 device; mapbase=0xfe201000; irq=39; clockrate=48000001
Jan  1 01:00:34 localhost kern.info kernel: [   34.683423] pl011_raw_uart fe201000.serial: Missing I2C driver of rtc device, trying to load
Jan  1 01:00:34 localhost kern.info kernel: [   34.683429] pl011_raw_uart fe201000.serial: Requesting module i2c:rx8130
Jan  1 01:00:34 localhost kern.warn kernel: [   34.701455] rtc-ds1307: probe of 1-0032 failed with error -5
Jan  1 01:00:34 localhost kern.warn kernel: [   34.705568] rtc-ds1307: probe of 1-0032 failed with error -5
Jan  1 01:00:34 localhost kern.info kernel: [   34.706127] raw-uart raw-uart: Reset radio module
Jan  1 01:00:34 localhost kern.info kernel: [   34.742601] cdc_acm 1-1.3:1.0: ttyACM0: USB ACM device
Jan  1 01:00:34 localhost kern.info kernel: [   34.742711] usbcore: registered new interface driver cdc_acm
Jan  1 01:00:34 localhost kern.info kernel: [   34.742720] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
Jan  1 01:00:34 localhost kern.notice kernel: [   34.820650] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Jan  1 01:00:34 localhost kern.notice kernel: [   34.829666] cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf'
Jan  1 01:00:34 localhost kern.notice kernel: [   34.830100] cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328'
Jan  1 01:00:34 localhost kern.notice kernel: [   34.830496] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Jan  1 01:00:34 localhost kern.notice kernel: [   34.830888] cfg80211: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
Jan  1 01:00:34 localhost kern.debug kernel: [   34.875825] brcmfmac: F1 signature read @0x18000000=0x15264345
Jan  1 01:00:34 localhost kern.info kernel: [   34.879357] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan  1 01:00:34 localhost kern.info kernel: [   34.879793] usbcore: registered new interface driver brcmfmac
Jan  1 01:00:34 localhost kern.info kernel: [   34.893319] raw-uart raw-uart: Registered new raw-uart device using underlying device GPIO@fe201000.serial.
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ arch_timer(11) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ fe00b880.mailbox(14) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ DMA IRQ(15) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ DMA IRQ(16) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ DMA IRQ(17) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ arm-pmu(23) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ arm-pmu(24) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ arm-pmu(25) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ arm-pmu(26) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ PCIe PME, aerdrv(30) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ xhci_hcd(33) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ VCHIQ doorbell(34) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ mmc1, mmc0(36) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ fe804000.i2c(37) guessed as class 0
Jan  1 01:00:34 localhost daemon.debug /usr/sbin/irqbalance: IRQ fe204000.spi(38) guessed as class 0
Jan  1 01:00:35 localhost user.notice rfkill: block set for type bluetooth
Jan  1 01:00:35 localhost kern.info kernel: [   35.099080] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov  1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60
Jan  1 01:00:35 localhost kern.info kernel: [   35.108467] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
Jan  1 01:00:35 localhost kern.info kernel: [   35.109134] bcmgenet fd580000.ethernet eth0: Link is Down
Jan  1 01:00:39 localhost kern.info kernel: [   39.197582] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Jan  1 01:00:39 localhost kern.info kernel: [   39.198124] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
Jan  1 01:00:41 localhost syslog.info syslogd exiting
Jan  1 01:00:41 homematic-raspi syslog.info syslogd started: BusyBox v1.36.1
Jan  1 01:00:41 homematic-raspi kern.notice kernel: klogd started: BusyBox v1.36.1 (2024-03-16 11:29:00 UTC)
Jan  1 01:00:41 homematic-raspi daemon.info udhcpc[1199]: started, v1.36.1
Jan  1 01:00:41 homematic-raspi daemon.info udhcpc[1199]: broadcasting discover
Jan  1 01:00:41 homematic-raspi daemon.info udhcpc[1199]: broadcasting select for 192.168.1.7, server 192.168.1.1
Jan  1 01:00:41 homematic-raspi daemon.info udhcpc[1199]: lease of 192.168.1.7 obtained from 192.168.1.1, lease time 864000
Jan  1 01:00:42 homematic-raspi user.info firewall: configuration set
Jan  1 01:00:42 homematic-raspi user.notice rfkill: block set for type wlan
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(eth0)[1346]: ifplugd 0.28 initializing.
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(eth0)[1346]: Using interface eth0/DC:A6:32:71:F9:BC with driver <bcmgenet> (version: 6.1.73)
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(eth0)[1346]: Using detection mode: SIOCETHTOOL
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(eth0)[1346]: Initialization complete, link beat detected.
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(eth0)[1346]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Jan  1 01:00:42 homematic-raspi daemon.warn ifplugd(eth0)[1346]: client: ifup: interface eth0 already configured
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(eth0)[1346]: Program executed successfully.
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(wlan0)[1351]: ifplugd 0.28 initializing.
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(wlan0)[1351]: Using interface wlan0/DC:A6:32:71:F9:BD with driver <brcmfmac> (version: 7.45.241)
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(wlan0)[1351]: Using detection mode: wireless extension
Jan  1 01:00:42 homematic-raspi daemon.info ifplugd(wlan0)[1351]: Initialization complete, link beat not detected.
Jan  1 01:00:45 homematic-raspi daemon.debug /usr/sbin/irqbalance: IRQ eth0(31) guessed as class 5
Jan  1 01:00:45 homematic-raspi daemon.debug /usr/sbin/irqbalance: IRQ eth0(32) guessed as class 5
Jan  1 01:00:45 homematic-raspi daemon.warn /usr/sbin/irqbalance: Cannot change IRQ 23 affinity: Input/output error
Jan  1 01:00:45 homematic-raspi daemon.warn /usr/sbin/irqbalance: IRQ 23 affinity is now unmanaged
Jan  1 01:00:45 homematic-raspi daemon.warn /usr/sbin/irqbalance: Cannot change IRQ 24 affinity: Input/output error
Jan  1 01:00:45 homematic-raspi daemon.warn /usr/sbin/irqbalance: IRQ 24 affinity is now unmanaged
Jan  1 01:00:45 homematic-raspi daemon.warn /usr/sbin/irqbalance: Cannot change IRQ 25 affinity: Input/output error
Jan  1 01:00:45 homematic-raspi daemon.warn /usr/sbin/irqbalance: IRQ 25 affinity is now unmanaged
Jan  1 01:00:45 homematic-raspi daemon.warn /usr/sbin/irqbalance: Cannot change IRQ 26 affinity: Input/output error
Jan  1 01:00:45 homematic-raspi daemon.warn /usr/sbin/irqbalance: IRQ 26 affinity is now unmanaged
Apr  1 22:23:12 homematic-raspi daemon.notice ntpdate[1358]: step time server 79.133.44.137 offset +1712002939.738902 sec
Apr  1 22:23:12 homematic-raspi daemon.info chronyd[1361]: chronyd version 4.4 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH +IPV6 -DEBUG)
Apr  1 22:23:12 homematic-raspi daemon.info chronyd[1361]: Added source 192.168.1.1
Apr  1 22:23:12 homematic-raspi daemon.info chronyd[1361]: Added source ID#0000000001 (0.de.pool.ntp.org)
Apr  1 22:23:12 homematic-raspi daemon.info chronyd[1361]: Added source ID#0000000002 (1.de.pool.ntp.org)
Apr  1 22:23:12 homematic-raspi daemon.info chronyd[1361]: Added source ID#0000000003 (2.de.pool.ntp.org)
Apr  1 22:23:12 homematic-raspi daemon.info chronyd[1361]: Added source ID#0000000004 (3.de.pool.ntp.org)
Apr  1 22:23:12 homematic-raspi kern.info kernel: [   52.911887] raw-uart raw-uart: Reset radio module
Apr  1 22:23:14 homematic-raspi kern.info kernel: [   55.130655] raw-uart raw-uart: Reset radio module
Apr  1 22:23:18 homematic-raspi kern.info kernel: [   59.196680] raw-uart raw-uart: Reset radio module
Apr  1 22:23:19 homematic-raspi daemon.err xinetd[1466]: Unable to read included directory: /etc/config/xinetd.d [file=/etc/xinetd.conf] [line=14]
Apr  1 22:23:19 homematic-raspi daemon.crit xinetd[1466]: 1466 {init_services} no services. Exiting...
Apr  1 22:23:24 homematic-raspi daemon.debug /usr/sbin/irqbalance: IRQ (39) guessed as class 0
Apr  1 22:24:20 homematic-raspi daemon.info chronyd[1361]: Selected source 2a01:4f8:c2c:477d::2 (2.de.pool.ntp.org)
Apr  1 22:28:19 homematic-raspi local0.err ReGaHss: ERROR: original file not exists, so try load new file. [LoadOM():iseDOM.cpp:2610]
Apr  1 22:28:19 homematic-raspi local0.err ReGaHss: ERROR: new file not exists, so try load bak file. [LoadOM():iseDOM.cpp:2622]
Apr  1 22:28:19 homematic-raspi local0.err ReGaHss: ERROR: failed open file= /etc/config/homematic.regadom.bak [LoadFromFile():iseDOMpersist.cpp:78]
Apr  1 22:28:19 homematic-raspi local0.err ReGaHss: ERROR: (202) failed! Already in map! [Insert():iseDOMobj.cpp:526]
Apr  1 22:28:19 homematic-raspi local0.err ReGaHss: ERROR: IseAddFavorite failed! ID=202 [IseAddFavorite():iseDOM.cpp:644]
Apr  1 22:28:19 homematic-raspi local0.err ReGaHss: ERROR: (203) failed! Already in map! [Insert():iseDOMobj.cpp:526]
Apr  1 22:28:19 homematic-raspi local0.err ReGaHss: ERROR: IseAddFavorite failed! ID=203 [IseAddFavorite():iseDOM.cpp:644]
Apr  1 22:28:19 homematic-raspi local0.err ReGaHss: ERROR: (204) failed! Already in map! [Insert():iseDOMobj.cpp:526]
Apr  1 22:28:19 homematic-raspi local0.err ReGaHss: ERROR: IseAddFavorite failed! ID=204 [IseAddFavorite():iseDOM.cpp:644]
Apr  1 22:28:22 homematic-raspi user.info homematic: meine-homematic.de Versions - Upgrade auf 1.503
Apr  1 22:28:22 homematic-raspi user.info homematic: meine-homematic.de VPN Dienst und Autoupdate DEAKTIVIERT
Apr  1 20:28:25 homematic-raspi daemon.info : starting pid 1922, tty '': '/bin/mv /tmp/boot.log /var/log/boot.log'
Apr  1 20:28:25 homematic-raspi daemon.info : starting pid 1923, tty '/dev/null': '/usr/bin/monit -Ic /etc/monitrc'
Apr  1 22:28:25 homematic-raspi user.info monit[1923]:  New Monit id: 1ee50be9fa480c121dc2a1539807b05c  Stored in '/usr/local/etc/monit.id'
Apr  1 22:28:25 homematic-raspi user.info monit[1923]: Starting Monit 5.33.0 daemon with http interface at /var/run/monit.sock
Apr  1 22:28:25 homematic-raspi user.info monit[1923]: 'homematic-raspi' Monit 5.33.0 started
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Apr  1 22:28:26 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'init': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:39292/groups, params: {"xmlrpc_bin://127.0.0.1:31999","1007"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2612]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'init' call failed (interface: 1007, params: {"xmlrpc_bin://127.0.0.1:31999","1007"}) [CallInit():iseXmlRpc.cpp:1214]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: failed CallInit() for interface=VirtualDevices [ThreadFunction():iseRTHss.cpp:163]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Apr  1 22:28:26 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'init': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"xmlrpc_bin://127.0.0.1:31999","1008"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2612]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'init' call failed (interface: 1008, params: {"xmlrpc_bin://127.0.0.1:31999","1008"}) [CallInit():iseXmlRpc.cpp:1214]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: failed CallInit() for interface=HmIP-RF [ThreadFunction():iseRTHss.cpp:163]
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: 'sshdEnabled' status failed (1) -- no output
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: 'hs485dEnabled' status failed (2) -- grep: /var/etc/hs485d.conf: No such file or directory
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: 'multimacdEnabled' status failed (1) -- no output
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: 'hmlangwEnabled' status failed (1) -- no output
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: 'rfdEnabled' status failed (1) -- no output
Apr  1 22:28:46 homematic-raspi user.warn monit[1923]: 'HMIPServer' failed protocol test [DEFAULT] at [localhost]:39292 [TCP/IP] -- Connection refused
Apr  1 22:28:46 homematic-raspi user.warn monit[1923]: 'hasUSB' status failed (1) -- no output
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: 'hb_rf_eth-CheckEnabled' status failed (1) -- no output
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: 'coProcessorCheck' status failed (1) -- no output
Apr  1 22:28:46 homematic-raspi user.warn monit[1923]: 'eMMCLifeTimeCheck' status failed (1) -- no output
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: 'tailscaleEnabled' status failed (1) -- no output
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: Lookup for '/media/usb1' filesystem failed  -- not found in /proc/self/mounts
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: Filesystem '/media/usb1' not mounted
Apr  1 22:28:46 homematic-raspi user.err monit[1923]: 'usb1' unable to read filesystem '/media/usb1' state
Apr  1 22:28:46 homematic-raspi user.info monit[1923]: 'usb1' trying to restart
Apr  1 22:29:02 homematic-raspi user.warn monit[1923]: 'HMIPServer' failed protocol test [DEFAULT] at [localhost]:39292 [TCP/IP] -- Connection refused
Apr  1 22:29:04 homematic-raspi user.warn monit[1923]: 'hasUSB' status failed (1) -- no output
Apr  1 22:29:04 homematic-raspi user.err monit[1923]: 'wlan0CheckEnabled' status failed (1) -- no output
Apr  1 22:29:04 homematic-raspi user.warn monit[1923]: 'eMMCLifeTimeCheck' status failed (1) -- no output
Apr  1 22:29:04 homematic-raspi user.err monit[1923]: Filesystem '/media/usb1' not mounted
Apr  1 22:29:04 homematic-raspi user.err monit[1923]: 'usb1' unable to read filesystem '/media/usb1' state
Apr  1 22:29:04 homematic-raspi user.info monit[1923]: 'usb1' trying to restart
Apr  1 22:29:20 homematic-raspi user.warn monit[1923]: 'HMIPServer' failed protocol test [DEFAULT] at [localhost]:39292 [TCP/IP] -- Connection refused
Apr  1 22:29:22 homematic-raspi user.warn monit[1923]: 'hasUSB' status failed (1) -- no output
Apr  1 22:29:22 homematic-raspi user.err monit[1923]: 'eMMCLifeTimeCheck' status failed (1) -- no output
Apr  1 22:29:22 homematic-raspi user.err monit[1923]: Filesystem '/media/usb1' not mounted
Apr  1 22:29:22 homematic-raspi user.err monit[1923]: 'usb1' unable to read filesystem '/media/usb1' state
Apr  1 22:29:22 homematic-raspi user.info monit[1923]: 'usb1' trying to restart
Apr  1 22:29:24 homematic-raspi user.info monit[1923]: 'lighttpd' restart on user request
Apr  1 22:29:24 homematic-raspi user.info monit[1923]: Monit daemon with PID 1923 awakened
Apr  1 22:29:24 homematic-raspi user.info monit[1923]: Awakened by User defined signal 1
Apr  1 22:29:24 homematic-raspi user.info monit[1923]: 'lighttpd' trying to restart
Apr  1 22:29:24 homematic-raspi user.info monit[1923]: 'lighttpd' restart: '/etc/init.d/S50lighttpd restart'
Apr  1 22:29:24 homematic-raspi user.info monit[1923]: 'lighttpd' restart action done
Apr  1 22:29:28 homematic-raspi user.warn monit[1923]: 'HMIPServer' failed protocol test [DEFAULT] at [localhost]:39292 [TCP/IP] -- Connection refused
Apr  1 22:29:29 homematic-raspi user.warn monit[1923]: 'hasUSB' status failed (1) -- no output
Apr  1 22:29:29 homematic-raspi user.err monit[1923]: Filesystem '/media/usb1' not mounted
Apr  1 22:29:29 homematic-raspi user.err monit[1923]: 'usb1' unable to read filesystem '/media/usb1' state
Apr  1 22:29:29 homematic-raspi user.info monit[1923]: 'usb1' trying to restart
Apr  1 22:29:46 homematic-raspi user.err monit[1923]: 'HMIPServer' failed protocol test [DEFAULT] at [localhost]:39292 [TCP/IP] -- Connection refused
Apr  1 22:29:46 homematic-raspi user.info monit[1923]: 'HMIPServer' trying to restart
Apr  1 22:29:46 homematic-raspi user.info monit[1923]: 'HMIPServer' restart: '/etc/init.d/S62HMServer restart'
Apr  1 22:30:16 homematic-raspi user.err monit[1923]: 'HMIPServer' failed to restart (exit status -1) -- '/etc/init.d/S62HMServer restart': Program timed out -- Stopping HMIPServer: OK Starting HMIPServer: ...............
Apr  1 22:30:17 homematic-raspi user.err monit[1923]: 'hasUSB' status failed (1) -- no output
Apr  1 22:30:34 homematic-raspi user.err monit[1923]: 'HMIPServer' service restarted 1 times within 1 cycles(s) - exec
Apr  1 22:30:34 homematic-raspi user.info monit[1923]: 'HMIPServer' exec: '/bin/triggerAlarm.tcl HMIPServer restarted WatchDog: hmipserver-restart true'
Apr  1 22:30:34 homematic-raspi user.info monit[1923]: 'HMIPServer' process is running after previous exec error (slow starting or manually recovered?)
Apr  1 22:30:34 homematic-raspi user.info monit[1923]: 'HMIPServer' process is running after previous restart timeout (manually recovered?)
Apr  1 22:30:34 homematic-raspi user.err monit[1923]: 'HMIPServer' failed protocol test [DEFAULT] at [localhost]:39292 [TCP/IP] -- Connection refused
Apr  1 22:30:34 homematic-raspi user.info monit[1923]: 'HMIPServer' trying to restart
Apr  1 22:30:34 homematic-raspi user.info monit[1923]: 'HMIPServer' restart: '/etc/init.d/S62HMServer restart'
Apr  1 22:31:04 homematic-raspi user.err monit[1923]: 'HMIPServer' failed to restart (exit status -1) -- '/etc/init.d/S62HMServer restart': Program timed out -- Stopping HMIPServer: OK Starting HMIPServer: ...............
Apr  1 22:31:22 homematic-raspi user.info monit[1923]: 'HMIPServer' process is running after previous exec error (slow starting or manually recovered?)
Apr  1 22:31:22 homematic-raspi user.err monit[1923]: 'HMIPServer' failed protocol test [DEFAULT] at [localhost]:39292 [TCP/IP] -- Connection refused
Apr  1 22:31:22 homematic-raspi user.info monit[1923]: 'HMIPServer' trying to restart
Apr  1 22:31:22 homematic-raspi user.info monit[1923]: 'HMIPServer' restart: '/etc/init.d/S62HMServer restart'
Apr  1 22:31:52 homematic-raspi user.err monit[1923]: 'HMIPServer' failed to restart (exit status -1) -- '/etc/init.d/S62HMServer restart': Program timed out -- Stopping HMIPServer: OK Starting HMIPServer: ...............
Apr  1 22:32:10 homematic-raspi user.err monit[1923]: 'HMIPServer' service restarted 1 times within 1 cycles(s) - exec
Apr  1 22:32:10 homematic-raspi user.info monit[1923]: 'HMIPServer' exec: '/bin/triggerAlarm.tcl HMIPServer restarted WatchDog: hmipserver-restart true'
Apr  1 22:32:10 homematic-raspi user.info monit[1923]: 'HMIPServer' process is running after previous exec error (slow starting or manually recovered?)
Apr  1 22:32:10 homematic-raspi user.info monit[1923]: 'HMIPServer' process is running after previous restart timeout (manually recovered?)
Apr  1 22:32:10 homematic-raspi user.err monit[1923]: 'HMIPServer' failed protocol test [DEFAULT] at [localhost]:39292 [TCP/IP] -- Connection refused
Apr  1 22:32:10 homematic-raspi user.info monit[1923]: 'HMIPServer' trying to restart
Apr  1 22:32:10 homematic-raspi user.info monit[1923]: 'HMIPServer' restart: '/etc/init.d/S62HMServer restart'
Apr  1 22:32:40 homematic-raspi user.err monit[1923]: 'HMIPServer' failed to restart (exit status -1) -- '/etc/init.d/S62HMServer restart': Program timed out -- Stopping HMIPServer: OK Starting HMIPServer: ...............

boot.log sieht ähnlich aus wie im HM Add-on.

/var/log/messages hat hier ein paar interessante Einträge:

Code: Alles auswählen

Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Apr  1 22:28:26 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'init': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:39292/groups, params: {"xmlrpc_bin://127.0.0.1:31999","1007"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2612]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'init' call failed (interface: 1007, params: {"xmlrpc_bin://127.0.0.1:31999","1007"}) [CallInit():iseXmlRpc.cpp:1214]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: failed CallInit() for interface=VirtualDevices [ThreadFunction():iseRTHss.cpp:163]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: XmlRpc: Error in XmlRpcClient::writeRequest: write error (error 111). [error():iseXmlRpc.h:281]
Apr  1 22:28:26 homematic-raspi local0.warn ReGaHss: WARNING: XMLRPC 'init': rpcClient.execute() failed (url: xmlrpc://127.0.0.1:32010, params: {"xmlrpc_bin://127.0.0.1:31999","1008"}, result: nil) [CallXmlrpcMethod():iseXmlRpc.cpp:2612]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: XMLRPC 'init' call failed (interface: 1008, params: {"xmlrpc_bin://127.0.0.1:31999","1008"}) [CallInit():iseXmlRpc.cpp:1214]
Apr  1 22:28:26 homematic-raspi local0.err ReGaHss: ERROR: failed CallInit() for interface=HmIP-RF [ThreadFunction():iseRTHss.cpp:163]

Weitere Tipps?

Viele Grüße

Benjamin

[benni123_]

Nachtrag: Die Alarm-Message ist auch wieder da.

Alles in allem scheint das hier nativ die gleiche Situation zu sein wie im HA Add-on ... Spannend.

Und wie versprochen noch ein paar Hardware-Bilder:

Lässt sich dort etwas erkennen? Platine richtig montiert?

Wiegesagt, mit der piVCCU läuft alles ...

[jp112sdl]

Gerade RM geflasht. System bootet

Poste bitte mal auch hiervon das Kernel Log (dmesg) vom Bootvorgang und auch die /var/log/messages

[benni123_]

Gerade RM geflasht. System bootet

Poste bitte mal auch hiervon das Kernel Log (dmesg) vom Bootvorgang und auch die /var/log/messages

Hallo Jérôme,

die /var/log/messages findet sich oben schon.

Eventuell lässt sich daran schon etwas sehen?

Das Kernel Log würde ich heute Abend rausziehen.

Schöne Grüße

Benjamin

[jp112sdl]

die /var/log/messages findet sich oben schon.

Das ist das von der reinen RaspberryMatic ohne HA?
Ohne eingespieltes Backup? Also komplett "blank"?

Eventuell lässt sich daran schon etwas sehen?

Das hier ist sehr komisch:

Code: Alles auswählen

Identifying Homematic RF-Hardware: ....HmRF: n/a, HmIP: HM-MOD-RPI-PCB/GPIO@fe201000.serial, OK

Dann müsste man mal /etc/init.d/S47InitRFHardware weiter debuggen, um zu schauen, warum hier keine HmRF Hardware erkannt wird

[Baxxy]

Die boot.log sieht nach frischem Start eines jungfräulichen Systems aus.

messages sieht nach eingespieltem Backup aus. (mit hier fürs Thema zwar unrelevanten aber unschönen Einträgen)

Diese "halbe Funkmodulerkennung" ist mir weiter vorn auch schon aufgefallen.

[jp112sdl]

messages sieht nach eingespieltem Backup aus

Nich dass in den Backup irgendeine ".noXXX" liegt, die irgendwas bei RM verhindert, was piVCCU ignoriert

Die Physik scheint ja grundsätzlich zu funktionieren, da das Modul an sich erkannt wird.

Ggf. auch mal /bin/detect_radio_module ausführen, aber vorher alle Schnittstellendienste stoppen

[Baxxy]

Auf jeden Fall ne komische Sache.
Mit nem jungfräulichen System (ohne Backup Restore) zu testen ist auf jeden Fall besser. Wobei die jungfräuliche boot.log ja auch schon den Fehler zeigt.

Wenn ich mal ignoriere das es mit piVCCU läuft bleiben ja nur das Funkmodul (und/oder dessen Firmware) oder der Pi4B als Fehlerquelle.