Nach Update HMCCU Fehlermeldungen und langsames FHEM

Begonnen von bmwfan, 12 November 2021, 12:27:32

Vorheriges Thema - Nächstes Thema
Drucken
Nach unten Seiten 1 2 3 Alle
Benutzer-Aktionen

LuckyDay

#15
15 November 2021, 00:22:02
Zitat von: Wernieman am 14 November 2021, 23:28:12
In dem Modul kann man die Menge der Folks einschränken (Frag mich nicht wie)
ZitatblockingCallMax
Begrenzt die Anzahl der parallel laufenden Prozesse, die von der BlockingCall FHEM Hilfsroutine gestartet wurden. Sinnvoll auf weniger leistungsfaehigen Hardware, die Voreinstellung ist 32. Nach erreichen dieser Grenze werden weitere Aufrufe verzögert.

findest unter global

MadMax-FHEM

#16
15 November 2021, 07:56:14 Letzte Bearbeitung: 15 November 2021, 08:01:02 von MadMax-FHEM
Zitat von: bmwfan am 14 November 2021, 10:36:18
Geswapt? Bedeutet das, dass der RAM-Speicher zu voll geworden ist und Teile auf die SD-Karte ausgelagert wurden?

Wie kann man herausfinden, was für den vollen Speicher verantwortlich ist?

Die pings:
5 Handys werden über das PRESENCE-Modul bei einer Fritzbox über
Code Auswählen
function {checkAllFritzMACpresent("XX:XX:XX:XX:XX:XX")} 60 60
alle 60 Sekunden abgefragt. 2 der Handys haben Android und die werden zusätzlich noch über einen Lan-Ping
Code Auswählen
lan-ping 192.168.178.38 60
auch alle 60-Sekunden abgefragt da ich gelesen habe, dass die Abfrage über die Fritzbox bei Android-Handys nicht zuverlässig funktioniert. Das ist schon seit mehreren Jahren so und ich hatte bisher keine Probleme bemerkt.

Was kann ich noch tun, damit das Problem nicht noch einmal auftritt?

Zum automatischen Start: Wie habt ihr denn euer System eingerichtet?
Grüße Jürgen

EDIT:
Zitat
   CGroup: /system.slice/fhem.service
           ├─19823 /usr/bin/perl fhem.pl fhem.cfg
           ├─19981 /usr/bin/perl fhem.pl fhem.cfg
           ├─19982 /usr/bin/perl fhem.pl fhem.cfg
           ├─19983 /usr/bin/perl fhem.pl fhem.cfg
           ├─19984 /usr/bin/perl fhem.pl fhem.cfg
           ├─19985 /usr/bin/perl fhem.pl fhem.cfg
           ├─19986 /usr/bin/perl fhem.pl fhem.cfg
           ├─20019 /usr/bin/perl fhem.pl fhem.cfg
           ├─20107 /usr/bin/perl fhem.pl fhem.cfg
           ├─20115 /usr/bin/perl fhem.pl fhem.cfg
           └─20156 /usr/bin/perl fhem.pl fhem.cfg
sieht nach sehr vielen Forks aus...
...jeder Fork "zieht" sich den kompletten fhem-Speicher noch mal "rein"...

Wenn es wirklich forking ist und auch das Einschränken nicht hilft, dann ist evtl. das einen Blick wert: https://forum.fhem.de/index.php/topic,117007.msg1113644.html#msg1113644

Martin "bemängelt" dort gerade das Blocking, was ja schon mal gut ist das zu nutzen und fhem nicht zu blockieren aber halt für jeden Presence-Ping einen Fork macht...
..."seine Abwandlung" macht das besser...

Habe ich aber selbst noch nicht getestet (steht noch auf der Liste ;)  )...

Was läuft sonst noch auf dem PI?

Ich habe was von Conbee (und deCONZ) zigbee2mqtt gelesen...
Evtl. da auch mal abspecken und auf eine andere HW auslagern...

Gruß, Joachim
FHEM PI3B+ Bullseye: HM-CFG-USB, 40x HM, ZWave-USB, 13x ZWave, EnOcean-PI, 15x EnOcean, HUE/deCONZ, CO2, ESP-Multisensor, Shelly, alexa-fhem, ...
FHEM PI2 Buster: HM-CFG-USB, 25x HM, ZWave-USB, 4x ZWave, EnOcean-PI, 3x EnOcean, Shelly, ha-bridge, ...
FHEM PI3 Buster (Test)

bmwfan

#17
15 November 2021, 13:51:59
Jetzt hatte sich nicht nur FHEM sondern der ganze Pi aufgehängt. Musste den Stecker ziehen, zum wiederbeleben. Diese Meldung im Log:

Code Auswählen
2021.11.15 13:08:49.771 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.15 13:09:39.118 1: 192.168.178.47:1000 disconnected, waiting to reappear (HM485_LAN)
2021.11.15 13:09:39.277 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.15 13:09:42.127 3: HM485_LAN: connected to device 192.168.178.47:1000
2021.11.15 13:09:42.128 1: 192.168.178.47:1000 reappeared (HM485_LAN)
2021.11.15 13:09:45.081 3: HM485_LAN: Lan Device Information
2021.11.15 13:09:45.081 3: HM485_LAN: Protocol-Version: 01
2021.11.15 13:09:45.081 3: HM485_LAN: Interface-Type: eQ3-HMW-LGW
2021.11.15 13:09:45.081 3: HM485_LAN: Firmware-Version: 1.0.4
2021.11.15 13:09:45.081 3: HM485_LAN: Serial-Number: LEQ0636394
2021.11.15 13:09:45.082 3: HM485_LAN: Initialize the interface
2021.11.15 13:17:38.467 1: Timeout for SYSMON_blockingCall reached, terminated process 27302
2021.11.15 13:17:44.765 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.15 13:17:45.022 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.15 13:18:44.445 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.15 13:34:53.504 1: Including fhem.cfg
2021.11.15 13:34:53.576 3: telnetPort: port 7072 opened

Im pi:
Code Auswählen
pi@Raspi043BPlus:~ $ ps aux | grep fhem
fhem       665 72.8 17.7 178512 168440 ?       R    13:34   6:03 /usr/bin/perl fhem.pl fhem.cfg
fhem      2018  1.0 16.3 169424 154752 ?       S    13:39   0:02 /usr/bin/perl fhem.pl fhem.cfg
fhem      2020  0.4 16.3 169424 154688 ?       S    13:39   0:01 /usr/bin/perl fhem.pl fhem.cfg
fhem      2021  0.1 16.3 169424 154688 ?       S    13:39   0:00 /usr/bin/perl fhem.pl fhem.cfg
pi        2492  0.0  0.0   7360   496 pts/1    S+   13:43   0:00 grep --color=auto fhem
pi@Raspi043BPlus:~ $ free
              total        used        free      shared  buff/cache   available
Mem:         946392      480116      169620        7480      296656      411552
Swap:        102396           0      102396



@MadMax-FHEM:
Was läuft alles:
Code Auswählen
System Info
ConfigType: configFile
SVN rev: 25227
OS: linux
Perl: 5.28.1
uniqueId: 032...

Modules Model Count
BOSEST 1
CUL
CUL 1
CUL_HM
HM-SEN-MDIR-WM55 1
HM-MOD-RE-8 1
HM-ES-PMSW1-PL 1
HM-MOD-EM-8 1
HM-LC-SW2-FM 1
HM-RC-8 1
DOIF
Perl 3
FHEM 74
DOIFtools 1
ENIGMA2
DUO2 1
FB_CALLLIST 1
FB_CALLMONITOR 1
FHEMWEB 3
FRITZBOX 2
FRITZ!Repeater 3000 1
FRITZ!Box 7530 1
FileLog 84
GEOFANCY 1
HM485 8
HM485_LAN 1
HMCCU 1
HMCCUCHN 3
HMCCUDEV 7
HMCCURPCPROC 3
HMUARTLGW
HM-MOD-UART 1
HMinfo 1
HOMEMODE 1
HTTPMOD 3
pharmacy_emergency_service_germany 1
HTTPSRV 1
IPCAM 3
Jalousie 7
JeeLink
LaCrosseITPlusReader.10.1q 1
LaCrosse 2
MQTT2_DEVICE 11
shelly2rgbw_4w_split 8
owntracks_device 1
SHSW-1 3
SHSW-25 10
shellydimmer 1
zigbee2mqtt_human_body_movement_illuminance 1
ebus_analyzeReadingList 1
tasmota_basic_state_power1 1
zigbee2mqtt_bridge 1
eBus_daemon_splitter 1
tasmota_POW 3
zigbee2mqtt_human_body_movement 2
MQTT2_SERVER 1
MQTT_GENERIC_BRIDGE 1
PRESENCE
function 4
lan-ping 2
daemon 1
PROPLANTA 1
Pushover 2
RESIDENTS 1
ROOMMATE 5
Robonect 1
SVG 21
SYSMON 1
SamsungAV 1
Shelly
shellydimmer 1
TRAFFIC 2
UWZ 1
allowed 2
at 8
autocreate 1
dummy 52
eventTypes 1
expandJSON 1
freezemon 1
holiday 2
livetracking 1
logProxy 1
monitoring 2
msgConfig 1
notify 13
rain 1
readingsGroup 15
statistics 1
structure 2
telnet 1
weblink 9

ConbeeII ist für zigbeemqtt
CUL für Homematic

Kann mir jemand weiterhelfen?

Grüße Jürgen
Synology DS720+ mit Docker-Container und Haupt-FHEM, HM-LAN, Jalousienaktoren HmWired, Shelly-Devices; Raspi 3B+ mit piVCCU ohne FHEM-Instanz, CUL, JeeLink; Raspi 3B+ mit FHEM und HMUARTUSB,  Raspi 3B+ mit HMUARTGPIO, 1-wire, ebusd

Ralli

#18
15 November 2021, 14:06:45
Mal in eine ganz andere Richtung: schon mal eine andere SD-Karte probiert?
Gruß,
Ralli

Proxmox 8.4 Cluster mit HP ED800G2i7, Intel NUC11TNHi7+NUC7i5BNH, virtualisiertes fhem 6.4 dev, virtualisierte RaspberryMatic (3.83.6.20250705) mit HB-RF-ETH 1.3.0 / RPI-RF-MOD, HM-LAN-GW (1.4.1) und HMW-GW, FRITZBOX 7490 (07.59), FBDECT, Siri und Alexa

bmwfan

#19
15 November 2021, 14:45:46
Die ist gerade einmal etwa 6 Monate drin. Da es mit der letzten Karte (16GB) nach ca. 1,5 Jahren seltsame Ausfälle gab, habe ich eine deutlich größere Karte (64GB) gekauft und eingebaut. Ich kann mir nicht vorstellen, dass die auch schon defekt sein kann aber möglich ist alles.
Synology DS720+ mit Docker-Container und Haupt-FHEM, HM-LAN, Jalousienaktoren HmWired, Shelly-Devices; Raspi 3B+ mit piVCCU ohne FHEM-Instanz, CUL, JeeLink; Raspi 3B+ mit FHEM und HMUARTUSB,  Raspi 3B+ mit HMUARTGPIO, 1-wire, ebusd

Wernieman

#20
15 November 2021, 18:50:29
Steht im /var/log/kern.log (und/oder syslog) etwas zu der Absturzzeit?

Mich würde oom und i/o Fehler/Warnungen interessieren
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

bmwfan

#21
15 November 2021, 19:20:10
Ich verstehe beide logs nicht. Die Einträge sind nicht cronologisch???. Siehe Dateien im Anhang.

Synology DS720+ mit Docker-Container und Haupt-FHEM, HM-LAN, Jalousienaktoren HmWired, Shelly-Devices; Raspi 3B+ mit piVCCU ohne FHEM-Instanz, CUL, JeeLink; Raspi 3B+ mit FHEM und HMUARTUSB,  Raspi 3B+ mit HMUARTGPIO, 1-wire, ebusd

bmwfan

#22
15 November 2021, 20:43:10
Und schon wieder hat sich der Raspi aufgehängt:
FHEM-Log:
Code Auswählen
2021.11.15 20:16:42.496 1: 192.168.178.47:1000 disconnected, waiting to reappear (HM485_LAN)
2021.11.15 20:16:47.034 3: MQTT2_DEVICE set MQTT2_shellyswitch25_C45BBE75D1CC off
2021.11.15 20:16:47.268 3: PRESENCE (PsnceDaemon) - skip scan due to running job
2021.11.15 20:16:49.461 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.15 20:16:49.555 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.15 20:16:49.581 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.15 20:16:49.883 3: HM485_LAN: connected to device 192.168.178.47:1000
2021.11.15 20:16:49.884 1: 192.168.178.47:1000 reappeared (HM485_LAN)
2021.11.15 20:31:39.072 1: Including fhem.cfg
2021.11.15 20:31:39.144 3: telnetPort: port 7072 opened
2021.11.15 20:31:39.842 3: WEB: port 8083 opened
2021.11.15 20:31:39.852 3: WEBS: port 8084 opened
2021.11.15 20:31:41.080 2: Registering GEOFANCY geofancy for URL /geo...
2021.11.15 20:31:41.127 3: WEBhook: port 8088 opened
2021.11.15 20:31:41.716 2: eventTypes: loaded 10038 lines from ./log/eventTypes.txt
2021.11.15 20:31:41.757 3: Opening CUL_0 device /dev/serial/by-id/usb-busware.de_CUL868-if00
2021.11.15 20:31:41.809 3: Setting CUL_0 serial parameters to 9600,8,N,1
2021.11.15 20:31:41.918 3: CUL_0: Possible commands: BbCFiAZNkGMKUYRTVWXefmLltux
2021.11.15 20:31:41.923 3: CUL_0 device opened
2021.11.15 20:31:41.930 2: Switched CUL_0 rfmode to HomeMatic
2021.11.15 20:31:42.532 3: additional HM config file loaded: ./FHEM/HMConfig_SenTHPL.pm
2021.11.15 20:31:42.716 3: Opening myJeeLink1 device /dev/serial/by-id/usb-FTDI_FT232R_USB_UART_AL014JZA-if00-port0
2021.11.15 20:31:42.719 3: Setting myJeeLink1 serial parameters to 57600,8,N,1
2021.11.15 20:31:43.727 3: myJeeLink1 device opened
2021.11.15 20:31:44.856 3: TABLETUI: new ext defined infix:ftui/: dir:./www/tablet/:
2021.11.15 20:31:44.856 3: Registering HTTPSRV TABLETUI for URL /ftui   and assigned link ftui/ ...
2021.11.15 20:31:45.217 3: HM485: HM485: Converting device files
2021.11.15 20:31:45.218 3: HM485: ==============================
2021.11.15 20:31:45.219 3: HM485: hmw_central.xml up to date
2021.11.15 20:31:45.220 3: HM485: hmw_generic.xml up to date
2021.11.15 20:31:45.220 3: HM485: hmw_io12_sw14_dr.xml up to date
2021.11.15 20:31:45.220 3: HM485: hmw_io12_sw7_dr.xml up to date
2021.11.15 20:31:45.220 3: HM485: hmw_io12_sw7_dr_V3_02.xml up to date
2021.11.15 20:31:45.221 3: HM485: hmw_io_12_fm.xml up to date
2021.11.15 20:31:45.221 3: HM485: hmw_io_4_fm.xml up to date
2021.11.15 20:31:45.221 3: HM485: hmw_io_4_fm_V3_02.xml up to date
2021.11.15 20:31:45.221 3: HM485: hmw_io_sr_fm.xml up to date
2021.11.15 20:31:45.221 3: HM485: hmw_lc_bl1_dr.xml up to date
2021.11.15 20:31:45.221 3: HM485: hmw_lc_bl1_dr_V3_02.xml up to date
2021.11.15 20:31:45.222 3: HM485: hmw_lc_dim1l_dr.xml up to date
2021.11.15 20:31:45.222 3: HM485: hmw_lc_sw2_dr.xml up to date
2021.11.15 20:31:45.222 3: HM485: hmw_lc_sw2_dr_V3_02.xml up to date
2021.11.15 20:31:45.222 3: HM485: hmw_sen_sc_12_dr.xml up to date
2021.11.15 20:31:45.222 3: HM485: Loading available device files
2021.11.15 20:31:45.223 3: HM485: ==============================
2021.11.15 20:31:45.223 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_central.pm
2021.11.15 20:31:45.226 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_generic.pm
2021.11.15 20:31:45.228 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io12_sw14_dr.pm
2021.11.15 20:31:45.241 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io12_sw7_dr.pm
2021.11.15 20:31:45.256 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io12_sw7_dr_V3_02.pm
2021.11.15 20:31:45.270 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_12_fm.pm
2021.11.15 20:31:45.285 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_4_fm.pm
2021.11.15 20:31:45.300 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_4_fm_V3_02.pm
2021.11.15 20:31:45.314 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_sr_fm.pm
2021.11.15 20:31:45.329 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_bl1_dr.pm
2021.11.15 20:31:45.349 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_bl1_dr_V3_02.pm
2021.11.15 20:31:45.369 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_dim1l_dr.pm
2021.11.15 20:31:45.389 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_sw2_dr.pm
2021.11.15 20:31:45.405 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_sw2_dr_V3_02.pm
2021.11.15 20:31:45.420 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_sen_sc_12_dr.pm
2021.11.15 20:31:46.775 3: UPDATE_FTUI: Defined with URL https://raw.githubusercontent.com/knowthelist/fhem-tablet-ui/master/controls_fhemtabletui.txt and interval 86400 featurelevel 6.1
2021.11.15 20:31:47.648 3: Pollenflug: Defined with URL http://www.donnerwetter.de/pollenflug/region.hts?plz=88483&PTag=0 and interval 3600 featurelevel 6.1
2021.11.15 20:31:49.283 3: Opening my_callmonitor device 192.168.178.1:1012
2021.11.15 20:31:49.291 3: FB_CALLMONITOR (my_callmonitor) - loading cache file ./log/my_callmonitor.txt
2021.11.15 20:31:49.293 2: FB_CALLMONITOR (my_callmonitor) - read 35 contacts from Cache
2021.11.15 20:31:54.077 3: ArduinoNano_Zisterne: Defined with URL http://192.168.178.45/ and interval 61 featurelevel 6.1
2021.11.15 20:31:54.377 3: LaCrosse_Kueche: I/O device is myJeeLink1
2021.11.15 20:31:54.394 3: LaCrosse_Bad_EG: I/O device is myJeeLink1
2021.11.15 20:31:54.658 3: MQTT2_FHEM_Server: port 1883 opened
2021.11.15 20:31:58.333 1: HMCCU [myHMCCU3] CCU port 8181 is not reachable
2021.11.15 20:31:58.335 1: HMCCU [myHMCCU3] Initialized version 5.0 213171649
2021.11.15 20:31:58.335 1: HMCCU [myHMCCU3] Scheduling delayed initialization in 180 seconds
2021.11.15 20:31:58.342 3: myHMCCU3: unknown attribute rpcinterfaces. Type 'attr myHMCCU3 ?' for a detailed list.
2021.11.15 20:31:58.578 3: HMCCUDEV [Licht_BadOG_Spiegel] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:31:59.237 3: freezemon defined myFreezemon freezemon
2021.11.15 20:31:59.239 0: [Freezemon] myFreezemon: Unwrapping CallFn
2021.11.15 20:31:59.240 0: [Freezemon] myFreezemon: Unwrapping AnalyzeCommand
2021.11.15 20:31:59.240 0: [Freezemon] myFreezemon: Unwrapping HttpUtils_NonblockingGet
2021.11.15 20:31:59.240 0: [Freezemon] myFreezemon: Unwrapping Log3
2021.11.15 20:31:59.241 3: [Freezemon] myFreezemon: Wrapping Log3
2021.11.15 20:31:59.398 3: [SamsungAV] SamsungQ85 defined with host: 192.168.178.37 port: 8001
2021.11.15 20:31:59.616 3: NotdienstApotheke: interval is 0, no periodic updates will done.
2021.11.15 20:31:59.616 3: NotdienstApotheke: Defined with URL https://apothekenfinder.mobi/interface/json.php?device=web&source=not&search=88483 featurelevel 6.1
2021.11.15 20:32:01.145 2: HMCCURPCPROC [d_rpc178026BidCos_RF] CCU not ready. Trying later ...
2021.11.15 20:32:01.151 2: HMCCURPCPROC [d_rpc178026HmIP_RF] CCU not ready. Trying later ...
2021.11.15 20:32:01.224 3: Modul 90_Jalousie.pm: Init Done with Version V 0.00.09 von gevoo - 18.12.2015 modifiziert JG
2021.11.15 20:32:01.225 3: Name = Jal_KU_Fenster, Parameter = Jalousie Jal_KU_Fenster_03 39 2
2021.11.15 20:32:01.225 1: Jalousie mit Rolloaktor Jal_KU_Fenster_03 verbunden
2021.11.15 20:32:01.227 3: Name = Jal_KU_Sued, Parameter = Jalousie Jal_KU_Sued_03 64 2
2021.11.15 20:32:01.228 1: Jalousie mit Rolloaktor Jal_KU_Sued_03 verbunden
2021.11.15 20:32:01.230 3: Name = Jal_WZ_Fest_Ost, Parameter = Jalousie Jal_WZ_Fest_Ost_03 64 2
2021.11.15 20:32:01.230 1: Jalousie mit Rolloaktor Jal_WZ_Fest_Ost_03 verbunden
2021.11.15 20:32:01.232 3: Name = Jal_WZ_Fest_Sued, Parameter = Jalousie Jal_WZ_Fest_Sued_03 64 2
2021.11.15 20:32:01.232 1: Jalousie mit Rolloaktor Jal_WZ_Fest_Sued_03 verbunden
2021.11.15 20:32:01.234 3: Name = Jal_WZ_Schiebetuer, Parameter = Jalousie Jal_WZ_Schiebetuer_03 64 2
2021.11.15 20:32:01.234 1: Jalousie mit Rolloaktor Jal_WZ_Schiebetuer_03 verbunden
2021.11.15 20:32:01.236 3: Name = Jal_WZ_SuedWest, Parameter = Jalousie Jal_WZ_Fest_SuedWest_03 64 2
2021.11.15 20:32:01.236 1: Jalousie mit Rolloaktor Jal_WZ_Fest_SuedWest_03 verbunden
2021.11.15 20:32:01.238 3: Name = Jal_WZ_West, Parameter = Jalousie Jal_WZ_Fest_West_03 64 2
2021.11.15 20:32:01.238 1: Jalousie mit Rolloaktor Jal_WZ_Fest_West_03 verbunden
2021.11.15 20:32:02.180 3: HMCCUCHN [Alarm_KueOst_HmIP] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:32:02.229 3: HMCCUCHN [Alarm_KueOst_HmIP] Invalid value STATE for attribute statedatapoint
2021.11.15 20:32:02.245 3: HMCCUCHN [Alarm_KueSued_HmIP] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:32:02.278 3: HMCCUCHN [Alarm_KueSued_HmIP] Invalid value STATE for attribute statedatapoint
2021.11.15 20:32:02.288 3: HMCCUDEV [HmIP_BWTH_000C9A499EE32F_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:32:02.324 3: HMCCUDEV [HmIP_BWTH_000C9BE99C66F8_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:32:02.360 3: HMCCUDEV [HmIP_BWTH_000C9BE98E7AB8_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:32:02.400 3: HMCCUDEV [HmIP_BWTH_000C9A49A7E499_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:32:02.440 3: HMCCUDEV [HmIP_BWTH_000C9A4999F2BC_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:32:02.479 3: HMCCUDEV [HmIP_BDT_0008DA49929255_3] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:32:02.554 3: HMCCUCHN [Heiz_BadOG_Handtuch_HmIP] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.15 20:32:02.614 2: HMCCURPCPROC [d_rpc178026VirtualDevices] CCU not ready. Trying later ...
2021.11.15 20:32:02.618 1: Including ./log/fhem.save
2021.11.15 20:32:04.497 3: Opening myHMUARTGPIO device 192.168.178.53:4001
2021.11.15 20:32:04.499 1: CUL_HM start inital cleanup
2021.11.15 20:32:06.582 1: CUL_HM finished initial cleanup

kern.log:
[code]Nov 15 13:35:44 Raspi043BPlus kernel: [   65.265759] eq3loop: eq3loop_open_slave() mmd_hmip
Nov 15 20:20:08 Raspi043BPlus kernel: [24328.212056] INFO: task kworker/1:2:19649 blocked for more than 122 seconds.
Nov 15 20:20:09 Raspi043BPlus kernel: [24328.212081]       Tainted: G         C O      5.10.17-v7+ #1421
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212094] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212107] task:kworker/1:2     state:D stack:    0 pid:19649 ppid:     2 flags:0x00000000
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212173] Backtrace:
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212207] [<809ed8f0>] (__schedule) from [<809ee2c8>] (schedule+0x68/0xe4)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212232]  r10:82249800 r9:ffffe000 r8:00000000 r7:00000000 r6:60000113 r5:a3b84d80
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212244]  r4:ffffe000
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212263] [<809ee260>] (schedule) from [<807fabd0>] (__mmc_claim_host+0xe0/0x238)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212277]  r5:82249a18 r4:00000002
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212295] [<807faaf0>] (__mmc_claim_host) from [<807fad60>] (mmc_get_card+0x38/0x3c)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212313]  r10:00000000 r9:00000000 r8:00000040 r7:b6b42c00 r6:82249a18 r5:00000000
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212324]  r4:8224a800
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212344] [<807fad28>] (mmc_get_card) from [<8080499c>] (mmc_sd_detect+0x24/0x7c)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212357]  r5:82249800 r4:82249800
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212377] [<80804978>] (mmc_sd_detect) from [<807fd5bc>] (mmc_rescan+0xdc/0x3b0)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212390]  r5:82249800 r4:82249a7c
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212413] [<807fd4e0>] (mmc_rescan) from [<8013b980>] (process_one_work+0x250/0x5a0)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212431]  r9:00000000 r8:00000040 r7:b6b42c00 r6:b6b3f640 r5:a3ad1880 r4:82249a7c
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212450] [<8013b730>] (process_one_work) from [<8013bd30>] (worker_thread+0x60/0x5c4)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212469]  r10:b6b3f640 r9:80e03d00 r8:b6b3f658 r7:00000008 r6:b6b3f640 r5:a3ad1894
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212482]  r4:a3ad1880
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212504] [<8013bcd0>] (worker_thread) from [<801437b8>] (kthread+0x170/0x174)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212532]  r10:8465be74 r9:a3ad1880 r8:8013bcd0 r7:85e5c000 r6:00000000 r5:b0c55b00
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212545]  r4:847fde80
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212564] [<80143648>] (kthread) from [<801000ec>] (ret_from_fork+0x14/0x28)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212577] Exception stack(0x85e5dfb0 to 0x85e5dff8)
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212593] dfa0:                                     00000000 00000000 00000000 00000000
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212613] dfc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212628] dfe0: 00000000 00000000 00000000 00000000 00000013 00000000
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212646]  r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:80143648
Nov 15 20:20:10 Raspi043BPlus kernel: [24328.212658]  r4:b0c55b00
Nov 15 20:22:10 Raspi043BPlus kernel: [24451.092319]       Tainted: G         C O      5.10.17-v7+ #1421
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092331] task:kworker/1:2     state:D stack:    0 pid:19649 ppid:     2 flags:0x00000000
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092374] Backtrace:
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092403]  r10:82249800 r9:ffffe000 r8:00000000 r7:00000000 r6:60000113 r5:a3b84d80
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092419] [<809ee260>] (schedule) from [<807fabd0>] (__mmc_claim_host+0xe0/0x238)
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092436] [<807faaf0>] (__mmc_claim_host) from [<807fad60>] (mmc_get_card+0x38/0x3c)
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092451]  r4:8224a800
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092469]  r5:82249800 r4:82249800
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092487]  r5:82249800 r4:82249a7c
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092510]  r9:00000000 r8:00000040 r7:b6b42c00 r6:b6b3f640 r5:a3ad1880 r4:82249a7c
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092531]  r10:b6b3f640 r9:80e03d00 r8:b6b3f658 r7:00000008 r6:b6b3f640 r5:a3ad1894
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092548] [<8013bcd0>] (worker_thread) from [<801437b8>] (kthread+0x170/0x174)
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092563]  r4:847fde80
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092573] [<80143648>] (kthread) from [<801000ec>] (ret_from_fork+0x14/0x28)
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092579] Exception stack(0x85e5dfb0 to 0x85e5dff8)
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092588] dfa0:                                     00000000 00000000 00000000 00000000
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092597] dfc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092606] dfe0: 00000000 00000000 00000000 00000000 00000013 00000000
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092615]  r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:80143648
Nov 15 20:22:11 Raspi043BPlus kernel: [24451.092621]  r4:b0c55b00
Nov 15 20:24:14 Raspi043BPlus kernel: [24573.972638] INFO: task kworker/1:2:19649 blocked for more than 368 seconds.
Nov 15 20:24:19 Raspi043BPlus kernel: [24573.972669] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Nov 15 20:24:22 Raspi043BPlus kernel: [24573.972724] Workqueue: events_freezable mmc_rescan
Nov 15 20:24:23 Raspi043BPlus kernel: [24573.972773] [<809ed8f0>] (__schedule) from [<809ee2c8>] (schedule+0x68/0xe4)
Nov 15 20:24:25 Raspi043BPlus kernel: [24573.972801]  r4:ffffe000
Nov 15 20:24:27 Raspi043BPlus kernel: [24573.972830]  r5:82249a18 r4:00000002
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.972866]  r10:00000000 r9:00000000 r8:00000040 r7:b6b42c00 r6:82249a18 r5:00000000
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.972893] [<807fad28>] (mmc_get_card) from [<8080499c>] (mmc_sd_detect+0x24/0x7c)
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.972932] [<80804978>] (mmc_sd_detect) from [<807fd5bc>] (mmc_rescan+0xdc/0x3b0)
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.972966] [<807fd4e0>] (mmc_rescan) from [<8013b980>] (process_one_work+0x250/0x5a0)
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.973000] [<8013b730>] (process_one_work) from [<8013bd30>] (worker_thread+0x60/0x5c4)
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.973026]  r4:a3ad1880
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.973060]  r10:8465be74 r9:a3ad1880 r8:8013bcd0 r7:85e5c000 r6:00000000 r5:b0c55b00
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.973086] [<80143648>] (kthread) from [<801000ec>] (ret_from_fork+0x14/0x28)
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.973113] dfa0:                                     00000000 00000000 00000000 00000000
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.973128] dfc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.973143] dfe0: 00000000 00000000 00000000 00000000 00000013 00000000
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.973158]  r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:80143648
Nov 15 20:24:28 Raspi043BPlus kernel: [24573.973168]  r4:b0c55b00
Nov 15 20:26:17 Raspi043BPlus kernel: [24696.852917] INFO: task kworker/1:2:19649 blocked for more than 491 seconds.
Nov 15 20:26:21 Raspi043BPlus kernel: [24696.852943] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Nov 15 20:26:25 Raspi043BPlus kernel: [24696.852995] Workqueue: events_freezable mmc_rescan
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853039] [<809ed8f0>] (__schedule) from [<809ee2c8>] (schedule+0x68/0xe4)
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853064]  r4:ffffe000
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853091]  r5:82249a18 r4:00000002
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853121]  r10:00000000 r9:00000000 r8:00000040 r7:b6b42c00 r6:82249a18 r5:00000000
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853147] [<807fad28>] (mmc_get_card) from [<8080499c>] (mmc_sd_detect+0x24/0x7c)
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853171] [<80804978>] (mmc_sd_detect) from [<807fd5bc>] (mmc_rescan+0xdc/0x3b0)
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853199] [<807fd4e0>] (mmc_rescan) from [<8013b980>] (process_one_work+0x250/0x5a0)
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853233] [<8013b730>] (process_one_work) from [<8013bd30>] (worker_thread+0x60/0x5c4)
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853256]  r4:a3ad1880
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853287]  r10:8465be74 r9:a3ad1880 r8:8013bcd0 r7:85e5c000 r6:00000000 r5:b0c55b00
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853312] [<80143648>] (kthread) from [<801000ec>] (ret_from_fork+0x14/0x28)
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853333] dfa0:                                     00000000 00000000 00000000 00000000
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853348] dfc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853361] dfe0: 00000000 00000000 00000000 00000000 00000013 00000000
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853375]  r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:80143648
Nov 15 20:26:26 Raspi043BPlus kernel: [24696.853384]  r4:b0c55b00
Nov 15 20:28:19 Raspi043BPlus kernel: [24819.733199]       Tainted: G         C O      5.10.17-v7+ #1421
Nov 15 20:28:21 Raspi043BPlus kernel: [24819.733212] task:kworker/1:2     state:D stack:    0 pid:19649 ppid:     2 flags:0x00000000
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733253] Backtrace:
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733283]  r10:82249800 r9:ffffe000 r8:00000000 r7:00000000 r6:60000113 r5:a3b84d80
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733299] [<809ee260>] (schedule) from [<807fabd0>] (__mmc_claim_host+0xe0/0x238)
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733315] [<807faaf0>] (__mmc_claim_host) from [<807fad60>] (mmc_get_card+0x38/0x3c)
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733330]  r4:8224a800
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733348]  r5:82249800 r4:82249800
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733366]  r5:82249800 r4:82249a7c
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733388]  r9:00000000 r8:00000040 r7:b6b42c00 r6:b6b3f640 r5:a3ad1880 r4:82249a7c
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733408]  r10:b6b3f640 r9:80e03d00 r8:b6b3f658 r7:00000008 r6:b6b3f640 r5:a3ad1894
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733424] [<8013bcd0>] (worker_thread) from [<801437b8>] (kthread+0x170/0x174)
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733439]  r4:847fde80
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733450] [<80143648>] (kthread) from [<801000ec>] (ret_from_fork+0x14/0x28)
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733457] Exception stack(0x85e5dfb0 to 0x85e5dff8)
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733465] dfa0:                                     00000000 00000000 00000000 00000000
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733474] dfc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733482] dfe0: 00000000 00000000 00000000 00000000 00000013 00000000
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733491]  r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:80143648
Nov 15 20:28:22 Raspi043BPlus kernel: [24819.733497]  r4:b0c55b00
Nov 15 20:30:22 Raspi043BPlus kernel: [24942.613495] INFO: task kworker/1:2:19649 blocked for more than 737 seconds.
Nov 15 20:30:28 Raspi043BPlus kernel: [24942.613506]       Tainted: G         C O      5.10.17-v7+ #1421
Nov 15 20:30:32 Raspi043BPlus kernel: [24942.613511] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Nov 15 20:30:33 Raspi043BPlus kernel: [24942.613546] Workqueue: events_freezable mmc_rescan
Nov 15 20:30:34 Raspi043BPlus kernel: [24942.613575] [<809ed8f0>] (__schedule) from [<809ee2c8>] (schedule+0x68/0xe4)
Nov 15 20:30:39 Raspi043BPlus kernel: [24942.613593]  r4:ffffe000
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Booting Linux on physical CPU 0x0
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Linux version 5.10.17-v7+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1421 SMP Thu May 27 13:59:01 BST 2021
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] CPU: div instructions available: patching division code
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] OF: fdt: Machine model: Raspberry Pi 3 Model B Plus Rev 1.3
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Memory policy: Data cache writealloc
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Reserved memory: created CMA memory pool at 0x37400000, size 64 MiB
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Zone ranges:
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000]   DMA      [mem 0x0000000000000000-0x000000003b3fffff]
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000]   Normal   empty
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Movable zone start for each node
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Early memory node ranges
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000]   node   0: [mem 0x0000000000000000-0x000000003b3fffff]
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000003b3fffff]
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] On node 0 totalpages: 242688
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000]   DMA zone: 2133 pages used for memmap
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000]   DMA zone: 0 pages reserved
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000]   DMA zone: 242688 pages, LIFO batch:63
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] percpu: Embedded 20 pages/cpu s50700 r8192 d23028 u81920
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] pcpu-alloc: s50700 r8192 d23028 u81920 alloc=20*4096
Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] pcpu-alloc:
  • 0
  • 1
  • 2
  • 3
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 240555
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=tty1 root=PARTUUID=3de6e9d9-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Kernel parameter elevator= does not have any effect anymore.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Please use sysfs to set IO scheduler for individual devices.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] Memory: 879832K/970752K available (9216K kernel code, 1311K rwdata, 2940K rodata, 1024K init, 860K bss, 25384K reserved, 65536K cma-reserved)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] ftrace: allocating 31910 entries in 63 pages
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] ftrace: allocated 63 pages with 6 groups
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] rcu: Hierarchical RCU implementation.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000]    Rude variant of Tasks RCU enabled.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000]    Tracing variant of Tasks RCU enabled.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] random: get_random_bytes called from start_kernel+0x3ac/0x580 with crng_init=0
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] arch_timer: cp15 timer(s) running at 19.20MHz (phys).
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000008] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000025] Switching to timer-based delay loop, resolution 52ns
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.000314] Console: colour dummy device 80x30
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.001172] printk: console [tty1] enabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.001244] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.001304] pid_max: default: 32768 minimum: 301
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.001536] LSM: Security Framework initializing
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.001794] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.001845] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.003467] Disabling memory control group subsystem
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.003605] CPU: Testing write buffer coherency: ok
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.004122] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.005376] Setting up static identity map for 0x100000 - 0x10003c
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.005585] rcu: Hierarchical SRCU implementation.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.006524] smp: Bringing up secondary CPUs ...
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.007735] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.009045] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.010411] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.010571] smp: Brought up 1 node, 4 CPUs
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.010627] SMP: Total of 4 processors activated (153.60 BogoMIPS).
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.010658] CPU: All CPU(s) started in HYP mode.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.010686] CPU: Virtualization extensions available.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.011700] devtmpfs: initialized
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.029236] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.029529] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.029590] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.032840] pinctrl core: initialized pinctrl subsystem
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.034054] NET: Registered protocol family 16
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.038335] DMA: preallocated 1024 KiB pool for atomic coherent allocations
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.044107] audit: initializing netlink subsys (disabled)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.044429] audit: type=2000 audit(0.040:1): state=initialized audit_enabled=0 res=1
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.045032] thermal_sys: Registered thermal governor 'step_wise'
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.046001] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.046065] hw-breakpoint: maximum watchpoint size is 8 bytes.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.046363] Serial: AMBA PL011 UART driver
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.064912] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.080154] raspberrypi-firmware soc:firmware: Attached to firmware from 2021-05-27T14:04:13, variant start
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.090165] raspberrypi-firmware soc:firmware: Firmware hash is 7d9a298cda813f747b51fe17e1e417e7bf5ca94d
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.138753] bcm2835-dma 3f007000.dma: DMA legacy API manager, dmachans=0x1
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.141320] SCSI subsystem initialized
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.141592] usbcore: registered new interface driver usbfs
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.141692] usbcore: registered new interface driver hub
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.141795] usbcore: registered new device driver usb
    Nov 15 19:17:05 Raspi043BPlus kernel: [    0.143756] clocksource: Switched to clocksource arch_sys_counter
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.918362] VFS: Disk quotas dquot_6.6.0
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.918512] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.918739] FS-Cache: Loaded
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.918996] CacheFiles: Loaded
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.929529] NET: Registered protocol family 2
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.930582] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.930771] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.930919] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.931134] TCP: Hash tables configured (established 8192 bind 8192)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.931332] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.931412] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.931888] NET: Registered protocol family 1
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.932709] RPC: Registered named UNIX socket transport module.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.932744] RPC: Registered udp transport module.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.932774] RPC: Registered tcp transport module.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.932804] RPC: Registered tcp NFSv4.1 backchannel transport module.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.934617] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.938434] Initialise system trusted keyrings
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.938727] workingset: timestamp_bits=14 max_order=18 bucket_order=4
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.948378] zbud: loaded
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.950490] FS-Cache: Netfs 'nfs' registered for caching
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.951369] NFS: Registering the id_resolver key type
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.951440] Key type id_resolver registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.951471] Key type id_legacy registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.951647] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.952867] Key type asymmetric registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.952900] Asymmetric key parser 'x509' registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.952977] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.953018] io scheduler mq-deadline registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.953049] io scheduler kyber registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.956741] bcm2708_fb soc:fb: FB found 1 display(s)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.969058] Console: switching to colour frame buffer device 82x26
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.976260] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 656x416
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.985174] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.990076] bcm2835-rng 3f104000.rng: hwrng registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.993055] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    1.999136] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.016842] brd: module loaded
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.031621] loop: module loaded
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.035940] Loading iSCSI transport class v2.0-870.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.040262] libphy: Fixed MDIO Bus: probed
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.043181] usbcore: registered new interface driver lan78xx
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.045958] usbcore: registered new interface driver smsc95xx
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.048561] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.779369] Core Release: 2.80a
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.781837] Setting default values for core params
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.784367] Finished setting default values for core params
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.987283] Using Buffer DMA mode
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.989802] Periodic Transfer Interrupt Enhancement - disabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.992369] Multiprocessor Interrupt Enhancement - disabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.994927] OTG VER PARAM: 0, OTG VER FLAG: 0
    Nov 15 19:17:05 Raspi043BPlus kernel: [    2.997388] Dedicated Tx FIFOs mode
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.000301]
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.000322] WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = b7514000 dma = 0xf7514000 len=9024
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.007281] FIQ FSM acceleration enabled for :
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.007281] Non-periodic Split Transactions
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.007281] Periodic Split Transactions
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.007281] High-Speed Isochronous Endpoints
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.007281] Interrupt/Control Split Transaction hack enabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.018176] dwc_otg: Microframe scheduler enabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.018240]
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.018250] WARN::hcd_init_fiq:457: FIQ on core 1
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.022555]
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.022564] WARN::hcd_init_fiq:458: FIQ ASM at 807be568 length 36
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.026994]
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.027003] WARN::hcd_init_fiq:497: MPHI regs_base at bb810000
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.031485] dwc_otg 3f980000.usb: DWC OTG Controller
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.033894] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.036279] dwc_otg 3f980000.usb: irq 89, io mem 0x00000000
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.038611] Init: Port Power? op_state=1
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.040848] Init: Power Port (0)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.043374] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.048003] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.050467] usb usb1: Product: DWC OTG Controller
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.052829] usb usb1: Manufacturer: Linux 5.10.17-v7+ dwc_otg_hcd
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.055241] usb usb1: SerialNumber: 3f980000.usb
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.058357] hub 1-0:1.0: USB hub found
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.060792] hub 1-0:1.0: 1 port detected
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.064246] dwc_otg: FIQ enabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.064259] dwc_otg: NAK holdoff enabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.064271] dwc_otg: FIQ split-transaction FSM enabled
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.064289] Module dwc_common_port init
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.064618] usbcore: registered new interface driver usb-storage
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.067283] mousedev: PS/2 mouse device common for all mice
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.070880] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.076366] sdhci: Secure Digital Host Controller Interface driver
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.078910] sdhci: Copyright(c) Pierre Ossman
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.081989] mmc-bcm2835 3f300000.mmcnr: could not get clk, deferring probe
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.085324] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.088135] sdhci-pltfm: SDHCI platform and OF driver helper
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.092602] ledtrig-cpu: registered to indicate activity on CPUs
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.095659] hid: raw HID events driver (C) Jiri Kosina
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.098405] usbcore: registered new interface driver usbhid
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.101007] usbhid: USB HID core driver
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.108759] Initializing XFRM netlink socket
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.111373] NET: Registered protocol family 17
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.114045] Key type dns_resolver registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.117040] Registering SWP/SWPB emulation handler
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.119557] registered taskstats version 1
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.121894] Loading compiled-in X.509 certificates
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.125151] Key type ._fscrypt registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.127477] Key type .fscrypt registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.129801] Key type fscrypt-provisioning registered
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.144925] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.149118] mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.151514] mmc-bcm2835 3f300000.mmcnr: DMA channel allocated
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.180526] sdhost: log_buf @ (ptrval) (f7513000)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.221156] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.225137] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.228947] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.232600] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.237631] of_cfs_init
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.239844] of_cfs_init: OK
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.242688] Waiting for root device PARTUUID=3de6e9d9-02...
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.256625] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.273954] Indeed it is in host mode hprt0 = 00021501
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.344688] random: fast init done
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.385536] mmc0: host does not support reading read-only switch, assuming write-enable
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.394400] mmc0: new high speed SDXC card at address aaaa
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.397663] mmcblk0: mmc0:aaaa SD64G 59.5 GiB
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.404510] mmc1: new high speed SDIO card at address 0001
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.409381]  mmcblk0: p1 p2
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.427795] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.430142] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.483844] usb 1-1: new high-speed USB device number 2 using dwc_otg
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.486411] Indeed it is in host mode hprt0 = 00001101
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.521135] EXT4-fs (mmcblk0p2): orphan cleanup on readonly fs
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.543987] EXT4-fs (mmcblk0p2): 6 orphan inodes deleted
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.546381] EXT4-fs (mmcblk0p2): recovery complete
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.564979] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.569929] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.580676] devtmpfs: mounted
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.590721] Freeing unused kernel memory: 1024K
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.594254] Run /sbin/init as init process
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.596840]   with arguments:
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.596852]     /sbin/init
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.596863]   with environment:
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.596874]     HOME=/
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.596885]     TERM=linux
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.724230] usb 1-1: New USB device found, idVendor=0424, idProduct=2514, bcdDevice= b.b3
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.729589] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.733145] hub 1-1:1.0: USB hub found
    Nov 15 19:17:05 Raspi043BPlus kernel: [    3.736043] hub 1-1:1.0: 4 ports detected
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.053822] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.184161] usb 1-1.1: New USB device found, idVendor=0424, idProduct=2514, bcdDevice= b.b3
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.189552] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.193237] hub 1-1.1:1.0: USB hub found
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.196173] hub 1-1.1:1.0: 3 ports detected
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.303916] usb 1-1.2: new full-speed USB device number 4 using dwc_otg
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.360838] NET: Registered protocol family 10
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.365124] Segment Routing with IPv6
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.438281] usb 1-1.2: New USB device found, idVendor=1cf1, idProduct=0030, bcdDevice= 1.00
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.443894] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.446771] usb 1-1.2: Product: ConBee II
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.449631] usb 1-1.2: Manufacturer: dresden elektronik ingenieurtechnik GmbH
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.449644] usb 1-1.2: SerialNumber: DE2439922
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.553835] usb 1-1.1.2: new full-speed USB device number 5 using dwc_otg
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.714669] usb 1-1.1.2: New USB device found, idVendor=0403, idProduct=6f70, bcdDevice= 6.00
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.720582] usb 1-1.1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.727033] usb 1-1.1.2: Product: HB-RF-USB
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.730477] usb 1-1.1.2: Manufacturer: Alexander Reinert
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.733580] usb 1-1.1.2: SerialNumber: A93C9AVJ
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.783846] usb 1-1.3: new full-speed USB device number 6 using dwc_otg
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.941045] usb 1-1.3: New USB device found, idVendor=03eb, idProduct=204b, bcdDevice= 0.00
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.946706] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.949663] usb 1-1.3: Product: CUL868
    Nov 15 19:17:05 Raspi043BPlus kernel: [    4.952492] usb 1-1.3: Manufacturer: busware.de
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.023838] usb 1-1.1.3: new full-speed USB device number 7 using dwc_otg
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.191423] usb 1-1.1.3: New USB device found, idVendor=0403, idProduct=6001, bcdDevice= 6.00
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.196844] usb 1-1.1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.202451] usb 1-1.1.3: Product: FT232R USB UART
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.205329] usb 1-1.1.3: Manufacturer: FTDI
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.208101] usb 1-1.1.3: SerialNumber: AL014JZA
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.442459] random: systemd: uninitialized urandom read (16 bytes read)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.459418] random: systemd: uninitialized urandom read (16 bytes read)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.470427] random: systemd: uninitialized urandom read (16 bytes read)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.514006] usb 1-1.1.1: new high-speed USB device number 8 using dwc_otg
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.644579] usb 1-1.1.1: New USB device found, idVendor=0424, idProduct=7800, bcdDevice= 3.00
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.649267] usb 1-1.1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.920823] lan78xx 1-1.1.1:1.0 (unnamed net_device) (uninitialized): No External EEPROM. Setting MAC Speed
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.923140] libphy: lan78xx-mdiobus: probed
    Nov 15 19:17:05 Raspi043BPlus kernel: [    5.951563] lan78xx 1-1.1.1:1.0 (unnamed net_device) (uninitialized): int urb period 64
    Nov 15 19:17:05 Raspi043BPlus kernel: [    6.463300] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.594971] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.598239] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.598268] [vc_sm_connected_init]: start
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.601141] [vc_sm_connected_init]: installed successfully
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.606665] generic_raw_uart: loading out-of-tree module taints kernel.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.608847] mc: Linux media interface: v0.10
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.625749] pl011_raw_uart 3f201000.serial: there is not valid maps for state default
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.625960] pl011_raw_uart 3f201000.serial: I2C adapter of configured RTC device is not yet initialized
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.625976] pl011_raw_uart 3f201000.serial: failed to initialize generic_raw_uart module
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.679721] videodev: Linux video capture interface: v2.00
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.712122] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.714429] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.718976] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.726510] bcm2835_audio bcm2835_audio: card created with 8 channels
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.727046] pl011_raw_uart 3f201000.serial: there is not valid maps for state default
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.727278] pl011_raw_uart 3f201000.serial: I2C adapter of configured RTC device is not yet initialized
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.727296] pl011_raw_uart 3f201000.serial: failed to initialize generic_raw_uart module
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.729234] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.751160] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.758972] pl011_raw_uart 3f201000.serial: there is not valid maps for state default
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.759164] pl011_raw_uart 3f201000.serial: Missing I2C driver of rtc device, trying to load
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.759183] pl011_raw_uart 3f201000.serial: Requesting module i2c:rx8130-legacy
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.771103] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.771758] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.773101] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.773509] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.773543] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.773569] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.773606] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.773628] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.777043] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.777416] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.793062] rtc-rx8130 1-0032: Unable to read registers #28..#30
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.793088] i2c i2c-1: probing for rx8130 failed
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.793124] rtc-rx8130: probe of 1-0032 failed with error -121
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.795551] usb 1-1.2: USB disconnect, device number 4
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.795901] rtc-rx8130 1-0032: Unable to read registers #28..#30
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.795919] i2c i2c-1: probing for rx8130 failed
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.795955] rtc-rx8130: probe of 1-0032 failed with error -121
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.825754] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.825939] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.863082] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.863155] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.871518] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.871572] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
    Nov 15 19:17:05 Raspi043BPlus kernel: [    7.998531] cfg80211: Loading compiled-in X.509 certificates for regulatory database
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.003976] pl011_raw_uart 3f201000.serial: Initialized pl011 device; mapbase=0x3f201000; irq=114; clockrate=47999625
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.093851] usb 1-1.2: new full-speed USB device number 9 using dwc_otg
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.135319] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.214869] brcmfmac: F1 signature read @0x18000000=0x15264345
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.228698] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.230620] usbcore: registered new interface driver brcmfmac
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.232539] usb 1-1.2: New USB device found, idVendor=1cf1, idProduct=0030, bcdDevice= 1.00
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.232566] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.232583] usb 1-1.2: Product: ConBee II
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.232598] usb 1-1.2: Manufacturer: dresden elektronik ingenieurtechnik GmbH
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.232613] usb 1-1.2: SerialNumber: DE2439922
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.277301] brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.raspberrypi,3-model-b-plus.txt failed with error -2
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.419396] cdc_acm 1-1.3:1.0: ttyACM0: USB ACM device
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.430582] cdc_acm 1-1.2:1.0: ttyACM1: USB ACM device
    Nov 15 19:17:05 Raspi043BPlus kernel: [    8.436526] usbcore: registered
Synology DS720+ mit Docker-Container und Haupt-FHEM, HM-LAN, Jalousienaktoren HmWired, Shelly-Devices; Raspi 3B+ mit piVCCU ohne FHEM-Instanz, CUL, JeeLink; Raspi 3B+ mit FHEM und HMUARTUSB,  Raspi 3B+ mit HMUARTGPIO, 1-wire, ebusd

Wernieman

#23
15 November 2021, 22:00:45
Hast Du vorher ein Reboot gemacht? Das kern.log ist deutlich kürzer (hört nach ~7 Sekunden auf) als das Vorheriere.
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

bmwfan

#24
16 November 2021, 07:22:51
Keinen Reboot, aber nicht alles kopiert. Fehler?

Heute Nacht wieder Absturz. Anbei die kompletten Logs. Vieleicht kannst Du was erkennen, ich leider nicht.

Das FHEM-Log. Scheint so, als ob die Probleme irgendwann um 05:21 angefangen haben.

Code Auswählen
2021.11.16 05:15:00.858 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:15:02.795 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:15:03.937 3: UWZ Unwetterzentrale: UWZ.1811 Done fetching data
2021.11.16 05:15:04.156 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:16:27.504 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:16:27.574 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:16:28.953 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:17:07.420 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:18:51.216 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:18:52.720 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:18:53.261 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:18:53.277 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:18:54.855 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:20:05.749 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:20:28.051 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:20:29.499 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:21:04.076 3: UWZ Unwetterzentrale: UWZ.1811 Done fetching data
2021.11.16 05:21:11.561 1: FRITZBOX FritzBox7530: Readout_Aborted.1931 Error: Timeout when reading Fritz!Box data.
2021.11.16 05:21:27.326 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:21:27.625 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:21:28.688 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:21:32.613 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:21:34.072 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:21:52.441 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:21:54.018 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:22:01.006 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:22:01.469 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:22:02.206 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:22:23.251 3: CUL_HM set HM_572922_Sw_02 statusRequest noArg
2021.11.16 05:22:26.002 3: CUL_HM set de_Bad_OG_Licht_Spiegel statusRequest noArg
2021.11.16 05:22:49.647 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:23:22.237 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:23:22.446 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:23:23.700 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:24:55.504 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:24:56.942 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:24:57.248 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:38:34.393 2: autocreate: define MQTT2_rpi02 MQTT2_DEVICE rpi02 MQTT2_FHEM_Server
2021.11.16 05:38:34.514 2: autocreate: define FileLog_MQTT2_rpi02 FileLog ./log/MQTT2_rpi02-%Y.log MQTT2_rpi02
2021.11.16 05:39:10.871 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:39:11.118 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 05:39:11.365 2: HMCCURPCPROC [d_rpc178026BidCos_RF] Received no events from interface CB2001178092178026 for 614.167011976242 seconds
2021.11.16 05:39:11.366 2: HMCCU [myHMCCU3] Reconnecting to CCU
2021.11.16 05:39:11.413 2: HMCCURPCPROC [d_rpc178026BidCos_RF] Registering callback http://192.168.178.92:7411/fh2001 of type A with ID CB2001178092178026 at http://192.168.178.26:2001
2021.11.16 05:39:12.403 2: HMCCURPCPROC [d_rpc178026HmIP_RF] Registering callback http://192.168.178.92:7420/fh2010 of type A with ID CB2010178092178026 at http://192.168.178.26:2010
2021.11.16 05:39:12.525 2: HMCCURPCPROC [d_rpc178026VirtualDevices] Registering callback http://192.168.178.92:14702/fh9292 of type A with ID CB9292178092178026 at http://192.168.178.26:9292/groups
2021.11.16 05:39:12.581 2: HMCCURPCPROC [d_rpc178026BidCos_RF] CB2001178092178026 NewDevice received 52 device and channel specifications
2021.11.16 05:39:13.731 2: HMCCURPCPROC [d_rpc178026VirtualDevices] CB9292178092178026 NewDevice received 16 device and channel specifications
2021.11.16 05:39:22.902 1: 192.168.178.47:1000 disconnected, waiting to reappear (HM485_LAN)
2021.11.16 05:39:23.272 1: FHEMWEB SSL/HTTPS error:  SSL accept attempt failed (peer: 192.168.178.52)
2021.11.16 06:35:39.536 2: PRESENCE (HASH(0x7149730)) - scan aboart
2021.11.16 06:35:40.191 1: ERROR: empty name in readingsBeginUpdate
2021.11.16 06:35:40.191 1: stacktrace:
2021.11.16 06:35:40.274 1:     main::readingsBeginUpdate           called by fhem.pl (5091)
2021.11.16 06:35:40.329 1:     main::readingsSingleUpdate          called by ./FHEM/73_PRESENCE.pm (861)
2021.11.16 06:35:40.330 1:     main::PRESENCE_daemonAbortedScan    called by FHEM/Blocking.pm (144)
2021.11.16 06:35:40.330 1:     main::BlockingStart                 called by FHEM/Blocking.pm (107)
2021.11.16 06:35:40.331 1:     main::BlockingCall                  called by ./FHEM/42_SYSMON.pm (916)
2021.11.16 06:35:40.331 1:     main::SYSMON_Update                 called by fhem.pl (3427)
2021.11.16 06:35:40.331 1:     main::HandleTimeout                 called by fhem.pl (695)
2021.11.16 06:35:40.487 1: PERL WARNING: Use of uninitialized value $name in concatenation (.) or string at fhem.pl line 4945.
2021.11.16 06:35:40.627 1: readingsUpdate(,daemonAboartCnt,1) missed to call readingsBeginUpdate first.
2021.11.16 06:35:40.627 1: stacktrace:
2021.11.16 06:35:40.628 1:     main::readingsBulkUpdate            called by fhem.pl (5092)
2021.11.16 06:35:40.628 1:     main::readingsSingleUpdate          called by ./FHEM/73_PRESENCE.pm (861)
2021.11.16 06:35:40.628 1:     main::PRESENCE_daemonAbortedScan    called by FHEM/Blocking.pm (144)
2021.11.16 06:35:40.628 1:     main::BlockingStart                 called by FHEM/Blocking.pm (107)
2021.11.16 06:35:40.629 1:     main::BlockingCall                  called by ./FHEM/42_SYSMON.pm (916)
2021.11.16 06:35:40.629 1:     main::SYSMON_Update                 called by fhem.pl (3427)
2021.11.16 06:35:40.629 1:     main::HandleTimeout                 called by fhem.pl (695)
2021.11.16 06:35:40.630 1: PERL WARNING: Use of uninitialized value $d in hash element at fhem.pl line 4681.
2021.11.16 06:35:40.630 1: PERL WARNING: Use of uninitialized value $dev in hash element at fhem.pl line 3764.
2021.11.16 06:55:57.551 1: Error: >HASH(0x7149730)< has no TYPE, but following keys: >READINGS,helper<
2021.11.16 07:06:35.833 1: Including fhem.cfg
2021.11.16 07:06:35.903 3: telnetPort: port 7072 opened
2021.11.16 07:06:36.649 3: WEB: port 8083 opened
2021.11.16 07:06:36.660 3: WEBS: port 8084 opened
2021.11.16 07:06:37.998 2: Registering GEOFANCY geofancy for URL /geo...
2021.11.16 07:06:38.048 3: WEBhook: port 8088 opened
2021.11.16 07:06:38.661 2: eventTypes: loaded 10047 lines from ./log/eventTypes.txt
2021.11.16 07:06:38.704 3: Opening CUL_0 device /dev/serial/by-id/usb-busware.de_CUL868-if00
2021.11.16 07:06:38.756 3: Setting CUL_0 serial parameters to 9600,8,N,1
2021.11.16 07:06:38.865 3: CUL_0: Possible commands: BbCFiAZNkGMKUYRTVWXefmLltux
2021.11.16 07:06:38.870 3: CUL_0 device opened
2021.11.16 07:06:38.879 2: Switched CUL_0 rfmode to HomeMatic
2021.11.16 07:06:39.513 3: additional HM config file loaded: ./FHEM/HMConfig_SenTHPL.pm
2021.11.16 07:06:39.704 3: Opening myJeeLink1 device /dev/serial/by-id/usb-FTDI_FT232R_USB_UART_AL014JZA-if00-port0
2021.11.16 07:06:39.707 3: Setting myJeeLink1 serial parameters to 57600,8,N,1
2021.11.16 07:06:40.716 3: myJeeLink1 device opened
2021.11.16 07:06:41.987 3: TABLETUI: new ext defined infix:ftui/: dir:./www/tablet/:
2021.11.16 07:06:41.987 3: Registering HTTPSRV TABLETUI for URL /ftui   and assigned link ftui/ ...
2021.11.16 07:06:42.402 3: HM485: HM485: Converting device files
2021.11.16 07:06:42.403 3: HM485: ==============================
2021.11.16 07:06:42.404 3: HM485: hmw_central.xml up to date
2021.11.16 07:06:42.405 3: HM485: hmw_generic.xml up to date
2021.11.16 07:06:42.405 3: HM485: hmw_io12_sw14_dr.xml up to date
2021.11.16 07:06:42.405 3: HM485: hmw_io12_sw7_dr.xml up to date
2021.11.16 07:06:42.406 3: HM485: hmw_io12_sw7_dr_V3_02.xml up to date
2021.11.16 07:06:42.406 3: HM485: hmw_io_12_fm.xml up to date
2021.11.16 07:06:42.406 3: HM485: hmw_io_4_fm.xml up to date
2021.11.16 07:06:42.406 3: HM485: hmw_io_4_fm_V3_02.xml up to date
2021.11.16 07:06:42.406 3: HM485: hmw_io_sr_fm.xml up to date
2021.11.16 07:06:42.407 3: HM485: hmw_lc_bl1_dr.xml up to date
2021.11.16 07:06:42.407 3: HM485: hmw_lc_bl1_dr_V3_02.xml up to date
2021.11.16 07:06:42.407 3: HM485: hmw_lc_dim1l_dr.xml up to date
2021.11.16 07:06:42.407 3: HM485: hmw_lc_sw2_dr.xml up to date
2021.11.16 07:06:42.408 3: HM485: hmw_lc_sw2_dr_V3_02.xml up to date
2021.11.16 07:06:42.408 3: HM485: hmw_sen_sc_12_dr.xml up to date
2021.11.16 07:06:42.408 3: HM485: Loading available device files
2021.11.16 07:06:42.408 3: HM485: ==============================
2021.11.16 07:06:42.408 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_central.pm
2021.11.16 07:06:42.412 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_generic.pm
2021.11.16 07:06:42.414 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io12_sw14_dr.pm
2021.11.16 07:06:42.429 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io12_sw7_dr.pm
2021.11.16 07:06:42.445 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io12_sw7_dr_V3_02.pm
2021.11.16 07:06:42.463 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_12_fm.pm
2021.11.16 07:06:42.480 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_4_fm.pm
2021.11.16 07:06:42.496 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_4_fm_V3_02.pm
2021.11.16 07:06:42.511 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_sr_fm.pm
2021.11.16 07:06:42.527 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_bl1_dr.pm
2021.11.16 07:06:42.551 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_bl1_dr_V3_02.pm
2021.11.16 07:06:42.572 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_dim1l_dr.pm
2021.11.16 07:06:42.594 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_sw2_dr.pm
2021.11.16 07:06:42.612 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_sw2_dr_V3_02.pm
2021.11.16 07:06:42.627 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_sen_sc_12_dr.pm
2021.11.16 07:06:44.122 3: UPDATE_FTUI: Defined with URL https://raw.githubusercontent.com/knowthelist/fhem-tablet-ui/master/controls_fhemtabletui.txt and interval 86400 featurelevel 6.1
2021.11.16 07:06:45.093 3: Pollenflug: Defined with URL http://www.donnerwetter.de/pollenflug/region.hts?plz=88483&PTag=0 and interval 3600 featurelevel 6.1
2021.11.16 07:06:46.814 3: Opening my_callmonitor device 192.168.178.1:1012
2021.11.16 07:06:46.824 3: FB_CALLMONITOR (my_callmonitor) - loading cache file ./log/my_callmonitor.txt
2021.11.16 07:06:46.826 2: FB_CALLMONITOR (my_callmonitor) - read 35 contacts from Cache
2021.11.16 07:06:51.706 3: ArduinoNano_Zisterne: Defined with URL http://192.168.178.45/ and interval 61 featurelevel 6.1
2021.11.16 07:06:52.019 3: LaCrosse_Kueche: I/O device is myJeeLink1
2021.11.16 07:06:52.038 3: LaCrosse_Bad_EG: I/O device is myJeeLink1
2021.11.16 07:06:52.319 3: MQTT2_FHEM_Server: port 1883 opened
2021.11.16 07:06:56.005 1: HMCCU [myHMCCU3] CCU port 8181 is not reachable
2021.11.16 07:06:56.007 1: HMCCU [myHMCCU3] Initialized version 5.0 213171649
2021.11.16 07:06:56.007 1: HMCCU [myHMCCU3] Scheduling delayed initialization in 180 seconds
2021.11.16 07:06:56.014 3: myHMCCU3: unknown attribute rpcinterfaces. Type 'attr myHMCCU3 ?' for a detailed list.
2021.11.16 07:06:56.212 3: HMCCUDEV [Licht_BadOG_Spiegel] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:56.815 3: freezemon defined myFreezemon freezemon
2021.11.16 07:06:56.817 0: [Freezemon] myFreezemon: Unwrapping CallFn
2021.11.16 07:06:56.817 0: [Freezemon] myFreezemon: Unwrapping AnalyzeCommand
2021.11.16 07:06:56.818 0: [Freezemon] myFreezemon: Unwrapping HttpUtils_NonblockingGet
2021.11.16 07:06:56.818 0: [Freezemon] myFreezemon: Unwrapping Log3
2021.11.16 07:06:56.819 3: [Freezemon] myFreezemon: Wrapping Log3
2021.11.16 07:06:56.954 3: [SamsungAV] SamsungQ85 defined with host: 192.168.178.37 port: 8001
2021.11.16 07:06:57.203 3: NotdienstApotheke: interval is 0, no periodic updates will done.
2021.11.16 07:06:57.204 3: NotdienstApotheke: Defined with URL https://apothekenfinder.mobi/interface/json.php?device=web&source=not&search=88483 featurelevel 6.1
2021.11.16 07:06:58.677 2: HMCCURPCPROC [d_rpc178026BidCos_RF] CCU not ready. Trying later ...
2021.11.16 07:06:58.684 2: HMCCURPCPROC [d_rpc178026HmIP_RF] CCU not ready. Trying later ...
2021.11.16 07:06:58.775 3: Modul 90_Jalousie.pm: Init Done with Version V 0.00.09 von gevoo - 18.12.2015 modifiziert JG
2021.11.16 07:06:58.776 3: Name = Jal_KU_Fenster, Parameter = Jalousie Jal_KU_Fenster_03 39 2
2021.11.16 07:06:58.776 1: Jalousie mit Rolloaktor Jal_KU_Fenster_03 verbunden
2021.11.16 07:06:58.779 3: Name = Jal_KU_Sued, Parameter = Jalousie Jal_KU_Sued_03 64 2
2021.11.16 07:06:58.779 1: Jalousie mit Rolloaktor Jal_KU_Sued_03 verbunden
2021.11.16 07:06:58.782 3: Name = Jal_WZ_Fest_Ost, Parameter = Jalousie Jal_WZ_Fest_Ost_03 64 2
2021.11.16 07:06:58.783 1: Jalousie mit Rolloaktor Jal_WZ_Fest_Ost_03 verbunden
2021.11.16 07:06:58.785 3: Name = Jal_WZ_Fest_Sued, Parameter = Jalousie Jal_WZ_Fest_Sued_03 64 2
2021.11.16 07:06:58.786 1: Jalousie mit Rolloaktor Jal_WZ_Fest_Sued_03 verbunden
2021.11.16 07:06:58.789 3: Name = Jal_WZ_Schiebetuer, Parameter = Jalousie Jal_WZ_Schiebetuer_03 64 2
2021.11.16 07:06:58.789 1: Jalousie mit Rolloaktor Jal_WZ_Schiebetuer_03 verbunden
2021.11.16 07:06:58.792 3: Name = Jal_WZ_SuedWest, Parameter = Jalousie Jal_WZ_Fest_SuedWest_03 64 2
2021.11.16 07:06:58.793 1: Jalousie mit Rolloaktor Jal_WZ_Fest_SuedWest_03 verbunden
2021.11.16 07:06:58.795 3: Name = Jal_WZ_West, Parameter = Jalousie Jal_WZ_Fest_West_03 64 2
2021.11.16 07:06:58.796 1: Jalousie mit Rolloaktor Jal_WZ_Fest_West_03 verbunden
2021.11.16 07:06:59.583 3: HMCCUCHN [Alarm_KueOst_HmIP] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:59.628 3: HMCCUCHN [Alarm_KueSued_HmIP] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:59.662 3: HMCCUDEV [HmIP_BWTH_000C9A499EE32F_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:59.697 3: HMCCUDEV [HmIP_BWTH_000C9BE99C66F8_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:59.732 3: HMCCUDEV [HmIP_BWTH_000C9BE98E7AB8_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:59.767 3: HMCCUDEV [HmIP_BWTH_000C9A49A7E499_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:59.802 3: HMCCUDEV [HmIP_BWTH_000C9A4999F2BC_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:59.837 3: HMCCUDEV [HmIP_BDT_0008DA49929255_3] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:59.913 3: HMCCUCHN [Heiz_BadOG_Handtuch_HmIP] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 07:06:59.974 2: HMCCURPCPROC [d_rpc178026VirtualDevices] CCU not ready. Trying later ...
2021.11.16 07:06:59.977 1: Including ./log/fhem.save
2021.11.16 07:07:01.896 3: Opening myHMUARTGPIO device 192.168.178.53:4001
2021.11.16 07:07:01.898 1: CUL_HM start inital cleanup
2021.11.16 07:07:03.839 1: CUL_HM finished initial cleanup
2021.11.16 07:07:03.913 3: monitoring (Activity_monitoring) set Activity_monitoring active
2021.11.16 07:07:04.095 3: monitoring (Batterie_monitoring) set Batterie_monitoring active
2021.11.16 07:07:04.183 3: [SamsungAV] device SamsungQ85 initialising....

Das sieht doch eher nach einem hardwareproblem aus, oder?

Die letzte Zeit habe ich doch einiges geändert (HMCCU hatte ein Update, das einige Änderungen erforderte), PRESENCE habe ich eine Version von martinp876 eingespielt, die weniger Wartezeiten verursachen soll...

Hoffe wir finden die Ursache.

Gruß Jürgen
Synology DS720+ mit Docker-Container und Haupt-FHEM, HM-LAN, Jalousienaktoren HmWired, Shelly-Devices; Raspi 3B+ mit piVCCU ohne FHEM-Instanz, CUL, JeeLink; Raspi 3B+ mit FHEM und HMUARTUSB,  Raspi 3B+ mit HMUARTGPIO, 1-wire, ebusd

Wernieman

#25
16 November 2021, 09:03:09
Ich sehe viel zu häufig den oom (OutOfMemory) Killer und auch sonstige Speichermangel Meldungen.

Wie schon mal gesagt:
- hast Du die Anzahl von Forks in FHEM begrenzt?
- Was läuft (abgesehen von FHEM) noch auf dem Rechner?

Insofern Hardwareproblem, das Du mit dem System einfach an die Speichergrenze des PIs kommst
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

zap

#26
16 November 2021, 09:45:41
Ich sehe da auch Netzwerkprobleme:

[myHMCCU3] CCU port 8181 is not reachable
2021.11.16 05:21:11.561 1: FRITZBOX FritzBox7530: Readout_Aborted.1931 Error: Timeout when reading Fritz!Box data.

Ich nehme an, die Fritzbox ist Dein Router. Das würde mir schon zu denken geben ...
2xCCU3 mit ca. 100 Aktoren, Sensoren
Entwicklung: FHEM auf Proxmox Debian VM
Produktiv inzwischen auf Home Assistant gewechselt.
Maintainer: HMCCU, (Fully, AndroidDB)

bmwfan

#27
16 November 2021, 09:57:33 Letzte Bearbeitung: 16 November 2021, 10:20:06 von bmwfan
Hatte gestern die Forks mit global BlockingCallMax auf 16 gestellt, aber heute Nacht war wieder ein Absturz. Was ist denn ein empfehlenswerter Wertt dafür?

Was läuft zu FHEM sonst noch?
Jeelink
zigbee2mqtt mit einem ConbeeII-Stick
Tablet-UI für Anzeige auf einem Tablet
HM485 wired für Ansteuerung Jalousien mit Interface eQ3-HMW-LGW
HmIP mit einer Hardware von Alexander Reiner
piVCCU
VCCU
MQTT2-Server für Shellys, Datenübertragung zu anderem RPI
Datenübertragung über MQTT2 von einem anderen Pi (ebusd, 1wire...)
Homemode-Modul
Residents-Modul, Roommate-Modul

@zap: Am Netzwerk wurde nichts verändert. Kann das nicht daher kommen, dass FHEM zu lange blockiert war und deswegen in einen TimeOut beid er Abfrage von Router und HMCCU gelaufen ist?

Nach einem reboot sieht es so aus:
Code Auswählen
pi@Raspi043BPlus:~ $ free
              total        used        free      shared  buff/cache   available
Mem:         945364      335348      251656       13388      358360      544184
Swap:        102396           0      102396

vorher waren nur 65 GB frei angezeigt.

Noch eine Ergänzung. Nach dem Neustart von FHEM scheint HMCCU nicht schnell genug zu starten und es kommen Fehlermeldungen.
Code Auswählen
2021.11.16 10:14:23.612 1: Including fhem.cfg
2021.11.16 10:14:23.697 3: telnetPort: port 7072 opened
2021.11.16 10:14:24.528 3: WEB: port 8083 opened
2021.11.16 10:14:24.540 3: WEBS: port 8084 opened
2021.11.16 10:14:26.158 2: Registering GEOFANCY geofancy for URL /geo...
2021.11.16 10:14:26.219 3: WEBhook: port 8088 opened
2021.11.16 10:14:26.887 2: eventTypes: loaded 10047 lines from ./log/eventTypes.txt
2021.11.16 10:14:27.029 3: Opening CUL_0 device /dev/serial/by-id/usb-busware.de_CUL868-if00
2021.11.16 10:14:27.097 3: Setting CUL_0 serial parameters to 9600,8,N,1
2021.11.16 10:14:27.207 3: CUL_0: Possible commands: BbCFiAZNkGMKUYRTVWXefmLltux
2021.11.16 10:14:27.212 3: CUL_0 device opened
2021.11.16 10:14:27.222 2: Switched CUL_0 rfmode to HomeMatic
2021.11.16 10:14:28.033 3: additional HM config file loaded: ./FHEM/HMConfig_SenTHPL.pm
2021.11.16 10:14:32.564 1: HMCCU [myHMCCU3] CCU port 8181 is not reachable
2021.11.16 10:14:32.565 1: HMCCU [myHMCCU3] Initialized version 5.0 213171649
2021.11.16 10:14:32.566 1: HMCCU [myHMCCU3] Scheduling delayed initialization in 180 seconds
2021.11.16 10:14:32.580 3: myHMCCU3: unknown attribute rpcinterfaces. Type 'attr myHMCCU3 ?' for a detailed list.
2021.11.16 10:14:32.930 3: Opening myJeeLink1 device /dev/serial/by-id/usb-FTDI_FT232R_USB_UART_AL014JZA-if00-port0
2021.11.16 10:14:32.935 3: Setting myJeeLink1 serial parameters to 57600,8,N,1
2021.11.16 10:14:33.957 3: myJeeLink1 device opened
2021.11.16 10:14:35.746 3: TABLETUI: new ext defined infix:ftui/: dir:./www/tablet/:
2021.11.16 10:14:35.747 3: Registering HTTPSRV TABLETUI for URL /ftui   and assigned link ftui/ ...
2021.11.16 10:14:36.372 3: HM485: HM485: Converting device files
2021.11.16 10:14:36.373 3: HM485: ==============================
2021.11.16 10:14:36.376 3: HM485: hmw_central.xml up to date
2021.11.16 10:14:36.376 3: HM485: hmw_generic.xml up to date
2021.11.16 10:14:36.377 3: HM485: hmw_io12_sw14_dr.xml up to date
2021.11.16 10:14:36.378 3: HM485: hmw_io12_sw7_dr.xml up to date
2021.11.16 10:14:36.379 3: HM485: hmw_io12_sw7_dr_V3_02.xml up to date
2021.11.16 10:14:36.379 3: HM485: hmw_io_12_fm.xml up to date
2021.11.16 10:14:36.380 3: HM485: hmw_io_4_fm.xml up to date
2021.11.16 10:14:36.381 3: HM485: hmw_io_4_fm_V3_02.xml up to date
2021.11.16 10:14:36.382 3: HM485: hmw_io_sr_fm.xml up to date
2021.11.16 10:14:36.382 3: HM485: hmw_lc_bl1_dr.xml up to date
2021.11.16 10:14:36.382 3: HM485: hmw_lc_bl1_dr_V3_02.xml up to date
2021.11.16 10:14:36.383 3: HM485: hmw_lc_dim1l_dr.xml up to date
2021.11.16 10:14:36.383 3: HM485: hmw_lc_sw2_dr.xml up to date
2021.11.16 10:14:36.384 3: HM485: hmw_lc_sw2_dr_V3_02.xml up to date
2021.11.16 10:14:36.385 3: HM485: hmw_sen_sc_12_dr.xml up to date
2021.11.16 10:14:36.385 3: HM485: Loading available device files
2021.11.16 10:14:36.386 3: HM485: ==============================
2021.11.16 10:14:36.386 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_central.pm
2021.11.16 10:14:36.391 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_generic.pm
2021.11.16 10:14:36.394 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io12_sw14_dr.pm
2021.11.16 10:14:36.406 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io12_sw7_dr.pm
2021.11.16 10:14:36.428 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io12_sw7_dr_V3_02.pm
2021.11.16 10:14:36.452 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_12_fm.pm
2021.11.16 10:14:36.475 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_4_fm.pm
2021.11.16 10:14:36.499 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_4_fm_V3_02.pm
2021.11.16 10:14:36.521 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_io_sr_fm.pm
2021.11.16 10:14:36.543 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_bl1_dr.pm
2021.11.16 10:14:36.573 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_bl1_dr_V3_02.pm
2021.11.16 10:14:36.603 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_dim1l_dr.pm
2021.11.16 10:14:36.636 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_sw2_dr.pm
2021.11.16 10:14:36.660 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_lc_sw2_dr_V3_02.pm
2021.11.16 10:14:36.687 3: HM485: Loading device file: ./FHEM/lib/HM485/Devices/hmw_sen_sc_12_dr.pm
2021.11.16 10:14:39.246 3: UPDATE_FTUI: Defined with URL https://raw.githubusercontent.com/knowthelist/fhem-tablet-ui/master/controls_fhemtabletui.txt and interval 86400 featurelevel 6.1
2021.11.16 10:14:40.605 3: Pollenflug: Defined with URL http://www.donnerwetter.de/pollenflug/region.hts?plz=88483&PTag=0 and interval 3600 featurelevel 6.1
2021.11.16 10:14:42.962 3: Opening my_callmonitor device 192.168.178.1:1012
2021.11.16 10:14:42.979 3: FB_CALLMONITOR (my_callmonitor) - loading cache file ./log/my_callmonitor.txt
2021.11.16 10:14:42.981 2: FB_CALLMONITOR (my_callmonitor) - read 35 contacts from Cache
2021.11.16 10:14:48.657 3: ArduinoNano_Zisterne: Defined with URL http://192.168.178.45/ and interval 61 featurelevel 6.1
2021.11.16 10:14:49.065 3: LaCrosse_Kueche: I/O device is myJeeLink1
2021.11.16 10:14:49.102 3: LaCrosse_Bad_EG: I/O device is myJeeLink1
2021.11.16 10:14:49.552 3: MQTT2_FHEM_Server: port 1883 opened
2021.11.16 10:14:50.220 3: HMCCUDEV [Licht_BadOG_Spiegel] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:51.161 3: freezemon defined myFreezemon freezemon
2021.11.16 10:14:51.165 0: [Freezemon] myFreezemon: Unwrapping CallFn
2021.11.16 10:14:51.165 0: [Freezemon] myFreezemon: Unwrapping AnalyzeCommand
2021.11.16 10:14:51.166 0: [Freezemon] myFreezemon: Unwrapping HttpUtils_NonblockingGet
2021.11.16 10:14:51.166 0: [Freezemon] myFreezemon: Unwrapping Log3
2021.11.16 10:14:51.168 3: [Freezemon] myFreezemon: Wrapping Log3
2021.11.16 10:14:51.410 3: [SamsungAV] SamsungQ85 defined with host: 192.168.178.37 port: 8001
2021.11.16 10:14:51.854 3: NotdienstApotheke: interval is 0, no periodic updates will done.
2021.11.16 10:14:51.854 3: NotdienstApotheke: Defined with URL https://apothekenfinder.mobi/interface/json.php?device=web&source=not&search=88483 featurelevel 6.1
2021.11.16 10:14:54.071 2: HMCCURPCPROC [d_rpc178026BidCos_RF] CCU not ready. Trying later ...
2021.11.16 10:14:54.080 2: HMCCURPCPROC [d_rpc178026HmIP_RF] CCU not ready. Trying later ...
2021.11.16 10:14:54.195 3: Modul 90_Jalousie.pm: Init Done with Version V 0.00.09 von gevoo - 18.12.2015 modifiziert JG
2021.11.16 10:14:54.196 3: Name = Jal_KU_Fenster, Parameter = Jalousie Jal_KU_Fenster_03 39 2
2021.11.16 10:14:54.196 1: Jalousie mit Rolloaktor Jal_KU_Fenster_03 verbunden
2021.11.16 10:14:54.199 3: Name = Jal_KU_Sued, Parameter = Jalousie Jal_KU_Sued_03 64 2
2021.11.16 10:14:54.199 1: Jalousie mit Rolloaktor Jal_KU_Sued_03 verbunden
2021.11.16 10:14:54.202 3: Name = Jal_WZ_Fest_Ost, Parameter = Jalousie Jal_WZ_Fest_Ost_03 64 2
2021.11.16 10:14:54.202 1: Jalousie mit Rolloaktor Jal_WZ_Fest_Ost_03 verbunden
2021.11.16 10:14:54.204 3: Name = Jal_WZ_Fest_Sued, Parameter = Jalousie Jal_WZ_Fest_Sued_03 64 2
2021.11.16 10:14:54.204 1: Jalousie mit Rolloaktor Jal_WZ_Fest_Sued_03 verbunden
2021.11.16 10:14:54.206 3: Name = Jal_WZ_Schiebetuer, Parameter = Jalousie Jal_WZ_Schiebetuer_03 64 2
2021.11.16 10:14:54.206 1: Jalousie mit Rolloaktor Jal_WZ_Schiebetuer_03 verbunden
2021.11.16 10:14:54.208 3: Name = Jal_WZ_SuedWest, Parameter = Jalousie Jal_WZ_Fest_SuedWest_03 64 2
2021.11.16 10:14:54.208 1: Jalousie mit Rolloaktor Jal_WZ_Fest_SuedWest_03 verbunden
2021.11.16 10:14:54.210 3: Name = Jal_WZ_West, Parameter = Jalousie Jal_WZ_Fest_West_03 64 2
2021.11.16 10:14:54.211 1: Jalousie mit Rolloaktor Jal_WZ_Fest_West_03 verbunden
2021.11.16 10:14:55.243 3: HMCCUCHN [Alarm_KueOst_HmIP] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:55.301 3: HMCCUCHN [Alarm_KueSued_HmIP] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:55.351 3: HMCCUDEV [HmIP_BWTH_000C9A499EE32F_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:55.402 3: HMCCUDEV [HmIP_BWTH_000C9BE99C66F8_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:55.452 3: HMCCUDEV [HmIP_BWTH_000C9BE98E7AB8_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:55.504 3: HMCCUDEV [HmIP_BWTH_000C9A49A7E499_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:55.556 3: HMCCUDEV [HmIP_BWTH_000C9A4999F2BC_9] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:55.612 3: HMCCUDEV [HmIP_BDT_0008DA49929255_3] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:55.725 3: HMCCUCHN [Heiz_BadOG_Handtuch_HmIP] Cannot detect IO device, maybe CCU not ready or device doesn't exist on CCU
2021.11.16 10:14:55.812 2: HMCCURPCPROC [d_rpc178026VirtualDevices] CCU not ready. Trying later ...
2021.11.16 10:14:55.816 1: Including ./log/fhem.save
2021.11.16 10:14:58.301 3: Opening myHMUARTGPIO device 192.168.178.53:4001
2021.11.16 10:14:58.304 1: CUL_HM start inital cleanup
2021.11.16 10:15:00.719 1: CUL_HM finished initial cleanup
2021.11.16 10:15:00.815 3: monitoring (Activity_monitoring) set Activity_monitoring active
2021.11.16 10:15:00.974 3: monitoring (Batterie_monitoring) set Batterie_monitoring active
2021.11.16 10:15:01.082 3: [SamsungAV] device SamsungQ85 initialising....
2021.11.16 10:15:01.154 3: telnetForBlockingFn_1637054101: port 33695 opened
2021.11.16 10:15:01.197 2: di_Bad_OG_Licht_Spiegel: set HmIP_BDT_0008DA49929255_3 off: Device state doesn't allow set commands
2021.11.16 10:15:01.198 3: di_Bad_OG_Licht_Spiegel: error in startup: set HmIP_BDT_0008DA49929255_3 off: Device state doesn't allow set commands
2021.11.16 10:15:01.472 1: PERL WARNING: Use of uninitialized value $4 in string at (eval 663) line 1.
2021.11.16 10:15:01.472 3: eval: {ReadingsTimestamp($name,"timer_02_c02","") =~ /^(\d+)-(\d+)-(\d+)\s(\d+:\d+):(\d+)$/;return "$4";}
2021.11.16 10:15:03.687 1: PERL WARNING: Use of uninitialized value in pattern match (m//) at ./FHEM/36_JeeLink.pm line 363.
2021.11.16 10:15:05.504 2: MQTT_GENERIC_BRIDGE: evalValue: user value ('{"$base/$roomname/$device/$sensor/$reading"}'') eval error: Global symbol "$roomname" requires explicit package name (did you forget to declare "my $roomname"?) at (eval 726) line 1.
Global symbol "$sensor" requires explicit package name (did you forget to declare "my $sensor"?) at (eval 726) line 1.

2021.11.16 10:15:05.857 0: Featurelevel: 6.1
2021.11.16 10:15:05.857 0: Server started with 505 defined entities (fhem.pl:25197/2021-11-07 perl:5.028001 os:linux user:fhem pid:674)
2021.11.16 10:15:06.974 1: PERL WARNING: Use of uninitialized value $hybernate in concatenation (.) or string at ./FHEM/86_Robonect.pm line 592.
2021.11.16 10:15:06.974 3: eval: sunset_abs()
2021.11.16 10:15:07.932 3: CUL_HM set AZ_Rolladen statusRequest noArg
2021.11.16 10:15:08.949 3: myHMUARTGPIO device opened
2021.11.16 10:15:09.350 1: FHEMWEB SSL/HTTPS error:  SSL accept attempt failed (peer: 192.168.178.52)
2021.11.16 10:15:10.669 3: Opening HM485_LAN device 192.168.178.47:1000
2021.11.16 10:15:10.673 3: HM485_LAN: connected to device 192.168.178.47:1000
2021.11.16 10:15:10.673 3: HM485_LAN device opened
2021.11.16 10:15:10.855 3: CUL_HM set FL_UG_Rolladen statusRequest noArg
2021.11.16 10:15:11.697 3: HM485_LAN: Lan Device Information
2021.11.16 10:15:11.697 3: HM485_LAN: Protocol-Version: 01
2021.11.16 10:15:11.697 3: HM485_LAN: Interface-Type: eQ3-HMW-LGW
2021.11.16 10:15:11.698 3: HM485_LAN: Firmware-Version: 1.0.4
2021.11.16 10:15:11.698 3: HM485_LAN: Serial-Number: LEQ0636394
2021.11.16 10:15:11.698 3: HM485_LAN: Initialize the interface
2021.11.16 10:15:12.615 3: UWZ Unwetterzentrale: UWZ.1811 Done fetching data
2021.11.16 10:15:12.963 3: CUL_HM set Gara_Re8_Sw01_TorAuf statusRequest noArg
2021.11.16 10:15:16.291 1: PERL WARNING: Use of uninitialized value $value in string eq at fhem.pl line 4926.
2021.11.16 10:15:16.649 3: HM485_LAN: Initialisierung von Modul 00010854
2021.11.16 10:15:16.814 3: CUL_HM set Gara_Re8_Sw02_TorLueften statusRequest noArg
2021.11.16 10:15:16.822 1: FHEMWEB SSL/HTTPS error:  SSL accept attempt failed error:1408F09C:SSL routines:ssl3_get_record:http request (peer: 192.168.178.92)
2021.11.16 10:15:17.414 3: HM485_LAN: Initialisierung von Modul 000107E1
2021.11.16 10:15:18.165 3: HM485_LAN: Initialisierung von Modul 0001076C
2021.11.16 10:15:18.326 3: CUL_HM set Gara_Re8_Sw03_TorZu statusRequest noArg
2021.11.16 10:15:18.334 3: Jal_WZ_Fest_SuedWest: Request config for device 00010854
2021.11.16 10:15:18.341 3: Jal_WZ_Fest_SuedWest: Lese Eeprom 00010854
2021.11.16 10:15:19.412 1: FHEMWEB SSL/HTTPS error:  SSL accept attempt failed error:1408F09C:SSL routines:ssl3_get_record:http request (peer: 192.168.178.92)
2021.11.16 10:15:19.416 3: HM485_LAN: Initialisierung von Modul 00010A77
2021.11.16 10:15:19.450 3: CUL_HM set Gara_Re8_Sw04_TorLicht statusRequest noArg
2021.11.16 10:15:21.460 3: CUL_HM set Gara_Re_8_Sw_05 statusRequest noArg
2021.11.16 10:15:21.618 3: HM485_LAN: Initialisierung von Modul 00010B2C
2021.11.16 10:15:21.748 3: Jal_WZ_Fest_West: Request config for device 000107E1
2021.11.16 10:15:21.755 3: Jal_WZ_Fest_West: Lese Eeprom 000107E1
2021.11.16 10:15:21.966 3: HM485_LAN: Initialisierung von Modul 00010AA7
2021.11.16 10:15:22.180 3: HM485_LAN: Initialisierung von Modul 00010A88
2021.11.16 10:15:23.272 3: HM485_LAN: Initialisierung von Modul 00010A70
2021.11.16 10:15:23.433 3: CUL_HM set Gara_Re_8_Sw_06 statusRequest noArg
2021.11.16 10:15:23.451 3: Jal_KU_Ost_00: Request config for device 0001076C
2021.11.16 10:15:23.458 3: Jal_KU_Ost_00: Lese Eeprom 0001076C
2021.11.16 10:15:25.032 3: CUL_HM set Gara_Re_8_Sw_07 statusRequest noArg
2021.11.16 10:15:25.826 2: AttrTemplates: got 259 entries
2021.11.16 10:15:26.772 3: CUL_HM set Gara_Re_8_Sw_08 statusRequest noArg
2021.11.16 10:15:30.176 3: CUL_HM set Licht_Gart_Hof statusRequest noArg
2021.11.16 10:15:33.439 3: CUL_HM set HM_572922_Sw_02 statusRequest noArg
2021.11.16 10:15:36.807 3: CUL_HM set Mar_Gar_Ost statusRequest noArg
2021.11.16 10:15:41.490 3: CUL_HM set Mar_Gar_West statusRequest noArg
2021.11.16 10:15:43.808 3: CUL_HM set WK_Steckdose_Waschen_Sw statusRequest noArg
2021.11.16 10:15:50.524 3: CUL_HM set de_Bad_OG_Licht_Spiegel statusRequest noArg
2021.11.16 10:15:57.626 3: Jal_KU_Fenster_00: Request config for device 00010A77
2021.11.16 10:15:57.632 3: Jal_KU_Fenster_00: Lese Eeprom 00010A77
2021.11.16 10:15:57.782 3: CUL_HM set HM_572922 getConfig noArg
2021.11.16 10:16:01.494 3: Jal_KU_Sued_00: Request config for device 00010B2C
2021.11.16 10:16:01.500 3: Jal_KU_Sued_00: Lese Eeprom 00010B2C
2021.11.16 10:16:08.900 3: Jal_WZ_Fest_Ost_00: Request config for device 00010AA7
2021.11.16 10:16:08.908 3: Jal_WZ_Fest_Ost_00: Lese Eeprom 00010AA7
2021.11.16 10:16:09.427 3: Jal_WZ_Fest_Sued_00: Request config for device 00010A88
2021.11.16 10:16:09.435 3: Jal_WZ_Fest_Sued_00: Lese Eeprom 00010A88
2021.11.16 10:16:09.953 3: Jal_WZ_Schiebetuer_00: Request config for device 00010A70
2021.11.16 10:16:09.963 3: Jal_WZ_Schiebetuer_00: Lese Eeprom 00010A70
2021.11.16 10:16:33.313 3: CUL_HM set de_Bad_OG_Licht_Spiegel getConfig noArg
2021.11.16 10:17:32.568 1: HMCCU [myHMCCU3] Initializing devices
2021.11.16 10:17:32.725 2: HMCCU [myHMCCU3] Deleting old groups
2021.11.16 10:17:32.731 2: HMCCU [myHMCCU3] Updating device table
2021.11.16 10:17:32.744 2: HMCCU [myHMCCU3] Initializing 13 client devices in state 'pending'
2021.11.16 10:17:32.745 2: HMCCU [myHMCCU3] Can't get device description for 00109BE989D89B:1  HMCCU_DetectDevice:187 HMCCUCHN_InitDevice:3129 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:32.746 2: HMCCU [myHMCCU3] Can't get device description for 00109BE989D89B:1  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:190 HMCCUCHN_InitDevice:3129 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:32.746 2: HMCCUCHN [Alarm_KueOst_HmIP] Can't get device description for 00109BE989D89B:1  HMCCU_UpdateDeviceRoles:193 HMCCUCHN_InitDevice:3129 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:32.754 1: HMCCURPCPROC [d_rpc178026HmIP_RF] Initialized version 5.0 213171649 for interface HmIP-RF with I/O device myHMCCU3
2021.11.16 10:17:33.156 1: HMCCURPCPROC [d_rpc178026VirtualDevices] Initialized version 5.0 213171649 for interface VirtualDevices with I/O device myHMCCU3
2021.11.16 10:17:33.389 2: HMCCU [myHMCCU3] Can't get device description for 000C9A4999F2BC  HMCCU_DetectDevice:212 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.390 2: HMCCU [myHMCCU3] Can't get device description for 000C9A4999F2BC  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:217 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.390 2: HMCCUDEV [HmIP_BWTH_000C9A4999F2BC_9] Can't get device description for 000C9A4999F2BC  HMCCU_UpdateDeviceRoles:220 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.394 2: HMCCU [myHMCCU3] Can't get device description for 000C9A499EE32F  HMCCU_DetectDevice:212 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.395 2: HMCCU [myHMCCU3] Can't get device description for 000C9A499EE32F  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:217 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.395 2: HMCCUDEV [HmIP_BWTH_000C9A499EE32F_9] Can't get device description for 000C9A499EE32F  HMCCU_UpdateDeviceRoles:220 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.399 2: HMCCU [myHMCCU3] Can't get device description for 000C9BE98E7AB8  HMCCU_DetectDevice:212 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.400 2: HMCCU [myHMCCU3] Can't get device description for 000C9BE98E7AB8  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:217 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.400 2: HMCCUDEV [HmIP_BWTH_000C9BE98E7AB8_9] Can't get device description for 000C9BE98E7AB8  HMCCU_UpdateDeviceRoles:220 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.408 1: HMCCURPCPROC [d_rpc178026BidCos_RF] Initialized version 5.0 213171649 for interface BidCos-RF with I/O device myHMCCU3
2021.11.16 10:17:33.638 2: HMCCU [myHMCCU3] Can't get device description for 00109BE989D6EC:1  HMCCU_DetectDevice:187 HMCCUCHN_InitDevice:3129 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.639 2: HMCCU [myHMCCU3] Can't get device description for 00109BE989D6EC:1  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:190 HMCCUCHN_InitDevice:3129 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.640 2: HMCCUCHN [Alarm_KueSued_HmIP] Can't get device description for 00109BE989D6EC:1  HMCCU_UpdateDeviceRoles:193 HMCCUCHN_InitDevice:3129 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.643 2: HMCCU [myHMCCU3] Can't get device description for 000A1D8991DD5F:1  HMCCU_DetectDevice:187 HMCCUCHN_InitDevice:3129 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.644 2: HMCCU [myHMCCU3] Can't get device description for 000A1D8991DD5F:1  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:190 HMCCUCHN_InitDevice:3129 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.645 2: HMCCUCHN [Heiz_BadOG_Handtuch_HmIP] Can't get device description for 000A1D8991DD5F:1  HMCCU_UpdateDeviceRoles:193 HMCCUCHN_InitDevice:3129 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.648 2: HMCCU [myHMCCU3] Can't get device description for 000C9A49A7E499  HMCCU_DetectDevice:212 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.649 2: HMCCU [myHMCCU3] Can't get device description for 000C9A49A7E499  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:217 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.650 2: HMCCUDEV [HmIP_BWTH_000C9A49A7E499_9] Can't get device description for 000C9A49A7E499  HMCCU_UpdateDeviceRoles:220 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.653 2: HMCCU [myHMCCU3] Can't get device description for 0008DA49929255  HMCCU_DetectDevice:212 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.654 2: HMCCU [myHMCCU3] Can't get device description for 0008DA49929255  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:217 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.654 2: HMCCUDEV [Licht_BadOG_Spiegel] Can't get device description for 0008DA49929255  HMCCU_UpdateDeviceRoles:220 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.655 2: HMCCU [myHMCCU3] Can't get device description for 000C9BE99C66F8  HMCCU_DetectDevice:212 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.656 2: HMCCU [myHMCCU3] Can't get device description for 000C9BE99C66F8  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:217 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.656 2: HMCCUDEV [HmIP_BWTH_000C9BE99C66F8_9] Can't get device description for 000C9BE99C66F8  HMCCU_UpdateDeviceRoles:220 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.661 2: HMCCU [myHMCCU3] Can't get device description for 0008DA49929255  HMCCU_DetectDevice:212 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.661 2: HMCCU [myHMCCU3] Can't get device description for 0008DA49929255  HMCCU_DetectDevice:3642 HMCCU_SetSCAttributes:217 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.662 2: HMCCUDEV [HmIP_BDT_0008DA49929255_3] Can't get device description for 0008DA49929255  HMCCU_UpdateDeviceRoles:220 HMCCUDEV_InitDevice:3128 HMCCU_UpdateDeviceTable:5635 HMCCU_GetDeviceList:536 HMCCU_InitDevice:3427 HandleTimeout:695
2021.11.16 10:17:33.887 1: HMCCU [myHMCCU3] Read 13 devices with 203 channels from CCU 192.168.178.26
2021.11.16 10:17:33.887 1: HMCCU [myHMCCU3] Read 0 programs from CCU 192.168.178.26
2021.11.16 10:17:33.887 1: HMCCU [myHMCCU3] Read 2 virtual groups from CCU 192.168.178.26
2021.11.16 10:17:33.887 1: HMCCU [myHMCCU3] Reading device config from CCU. This may take a couple of seconds ...
2021.11.16 10:17:33.888 2: HMCCU [myHMCCU3] Reading Device Descriptions for interface HmIP-RF
2021.11.16 10:17:34.750 2: HMCCU [myHMCCU3] Read 148 Device Descriptions for interface HmIP-RF
2021.11.16 10:17:34.751 2: HMCCU [myHMCCU3] Reading Paramset Descriptions for interface HmIP-RF
2021.11.16 10:17:48.354 2: HMCCU [myHMCCU3] Read 88 Paramset Descriptions for interface HmIP-RF
2021.11.16 10:17:48.355 2: HMCCU [myHMCCU3] Reading Peer Descriptions for interface HmIP-RF
2021.11.16 10:17:48.407 2: HMCCU [myHMCCU3] Read 12 Peer Descriptions for interface HmIP-RF
2021.11.16 10:17:48.407 2: HMCCU [myHMCCU3] Reading Device Descriptions for interface VirtualDevices
2021.11.16 10:17:48.521 2: HMCCU [myHMCCU3] Read 16 Device Descriptions for interface VirtualDevices
2021.11.16 10:17:48.522 2: HMCCU [myHMCCU3] Reading Paramset Descriptions for interface VirtualDevices
2021.11.16 10:17:51.619 2: HMCCU [myHMCCU3] Read 9 Paramset Descriptions for interface VirtualDevices
2021.11.16 10:17:51.620 2: HMCCU [myHMCCU3] Reading Peer Descriptions for interface VirtualDevices
2021.11.16 10:17:51.640 2: HMCCU [myHMCCU3] Read 0 Peer Descriptions for interface VirtualDevices
2021.11.16 10:17:51.641 2: HMCCU [myHMCCU3] Reading Device Descriptions for interface BidCos-RF
2021.11.16 10:17:51.800 2: HMCCU [myHMCCU3] Read 52 Device Descriptions for interface BidCos-RF
2021.11.16 10:17:51.801 2: HMCCU [myHMCCU3] Reading Paramset Descriptions for interface BidCos-RF
2021.11.16 10:17:54.304 2: HMCCU [myHMCCU3] Read 52 Paramset Descriptions for interface BidCos-RF
2021.11.16 10:17:54.305 2: HMCCU [myHMCCU3] Reading Peer Descriptions for interface BidCos-RF
2021.11.16 10:17:54.318 2: HMCCU [myHMCCU3] Read 0 Peer Descriptions for interface BidCos-RF
2021.11.16 10:17:54.335 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.337 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.339 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.341 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.342 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.361 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.362 1: PERL WARNING: Use of uninitialized value in concatenation (.) or string at ./FHEM/88_HMCCU.pm line 3660.
2021.11.16 10:17:54.365 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.374 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.377 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.386 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.390 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.406 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.409 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.434 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.438 2: HMCCU [myHMCCU3] Control datapoint not defined for channel 10, role
2021.11.16 10:17:54.454 2: HMCCU [myHMCCU3] Read RPC device configuration: devices/channels=216 parametersets=149 links=12
Synology DS720+ mit Docker-Container und Haupt-FHEM, HM-LAN, Jalousienaktoren HmWired, Shelly-Devices; Raspi 3B+ mit piVCCU ohne FHEM-Instanz, CUL, JeeLink; Raspi 3B+ mit FHEM und HMUARTUSB,  Raspi 3B+ mit HMUARTGPIO, 1-wire, ebusd

Wernieman

#28
16 November 2021, 10:18:27 Letzte Bearbeitung: 16 November 2021, 10:20:28 von Wernieman
ich meinte eigentlich, was läuft außerhalb von FHEM noch auf dem PI.
z.B. piVCCU ist so etwas.

bei dem PI würde ich 16 schon als deutlich zu hoch ansehen, eher bei 4-8 ..

Gib uns bitte mal bei einem frisch gestarteten System (nach c.a. 10 Minuten und als root (oder sudo)):
Code Auswählen
ps aux | grep fhem ; echo ; free
- Bitte um Input für Output
- When there is a Shell, there is a Way
- Wann war Dein letztes Backup?

Wie man Fragen stellt: https://tty1.net/smart-questions_de.html

bmwfan

#29
16 November 2021, 10:26:38
Gerade frisch gestartet:
Code Auswählen
pi@Raspi043BPlus:~ $ ps aux | grep fhem ; echo ; free
fhem      3984 78.9 15.8 160348 150272 ?       S    10:21   2:18 /usr/bin/perl fhem.pl fhem.cfg
fhem      4119  1.5 14.3 149780 135212 ?       S    10:22   0:01 /usr/bin/perl fhem.pl fhem.cfg
fhem      4122  0.4 14.2 149656 134980 ?       S    10:22   0:00 /usr/bin/perl fhem.pl fhem.cfg
fhem      4123  0.2 14.2 149668 135008 ?       S    10:22   0:00 /usr/bin/perl fhem.pl fhem.cfg
pi        4351  0.0  0.0   7360   492 pts/1    S+   10:24   0:00 grep --color=auto fhem

              total        used        free      shared  buff/cache   available
Mem:         945364      436880      144896       13508      363588      441980
Swap:        102396           0      102396


Seltsam. Bevor ich Fhem neu gestartet hatte waren es
Code Auswählen
pi@Raspi043BPlus:~ $ free
              total        used        free      shared  buff/cache   available
Mem:         945364      329668      252872       13508      362824      553652
Swap:        102396           0      102396


Kann es sein, dass bei einem restart von FHEM Reste zurückbleiben und den Speicher belegen?
Synology DS720+ mit Docker-Container und Haupt-FHEM, HM-LAN, Jalousienaktoren HmWired, Shelly-Devices; Raspi 3B+ mit piVCCU ohne FHEM-Instanz, CUL, JeeLink; Raspi 3B+ mit FHEM und HMUARTUSB,  Raspi 3B+ mit HMUARTGPIO, 1-wire, ebusd
Drucken
Nach oben Seiten 1 2 3 Alle
Benutzer-Aktionen