HM-MOD-UART disconnected, waiting to reappear (myHmUART)

Otto123 · 28 Januar 2020, 23:27:58

Sorry aber jetzt hast Du mich vollends verwirrt. Ich weiß jetzt nicht mehr welches Modul wo und welcher Fehler wo ist.
Ich meine jetzt verstanden zu haben:
Auf deinem produktiven Pi hast du prinzipiell Funktion mit beiden HMUART Modulen, aber ab und zu im Log den disconnect. Richtig? Wie oft ist der disconnect?
Auf dem Ersatz Pi läuft überhaupt nichts? Wieder mit beiden Modulen? Deine ganzen letzten (außer der allerletzte) lists waren von dem Ersatz Pi wo meiner Meinung nach gar nichts geht?

Gruß Otto

Udomatic · 28 Januar 2020, 23:48:16

Zitat von: Otto123 am 28 Januar 2020, 23:27:58
Sorry aber jetzt hast Du mich vollends verwirrt. Ich weiß jetzt nicht mehr welches Modul wo und welcher Fehler wo ist.

Das war nicht die Intention. Ich weiß deine Unterstützung zu schätzen!

Zitat von: Otto123 am 28 Januar 2020, 23:27:58
Ich meine jetzt verstanden zu haben:
Auf deinem produktiven Pi hast du prinzipiell Funktion mit beiden HMUART Modulen, aber ab und zu im Log den disconnect. Richtig? Wie oft ist der disconnect?

Auf dem produktiven Pi funktioniert das bisherige HMUART in Verbindung mit den disconnect Fehlern. Die kommen ca. alle 3-4 Minuten. Der allerletzte List ist davon.

Mit dem Backup Funkmodul aus dem Backup PI ging nichts im produktiven Pi. Daher rührte das List, wo du sagtest da geht gar nichts.
Aus diesem Grund habe ich wieder zurück gebaut. Obwohl das Funkmodul aus dem Backup Pi auch auf der Firmware Version 1.4.1 lief wurde das im produktiven System nicht erkannt!
Deshalb der Schnellschuss noch mal ein Firmware Update drüber zu bügeln.

Zitat von: Otto123 am 28 Januar 2020, 23:27:58
Auf dem Ersatz Pi läuft überhaupt nichts? Wieder mit beiden Modulen? Deine ganzen letzten (außer der allerletzte) lists waren von dem Ersatz Pi wo meiner Meinung nach gar nichts geht?
Gruß Otto

Vom Backup Pi habe ich dir kein List gesendet. Wie oben erwähnt habe ich lediglich das Funkmodul aus dem Backup Pi im produktiven getestet, was zu einem schlechteren Ergebnis führte bzw. wieder zu disconnects.

Otto123 · 28 Januar 2020, 23:59:00

ZitatAus diesem Grund habe ich wieder zurück gebaut. Obwohl das Funkmodul aus dem Backup Pi auch auf der Firmware Version 1.4.1 lief wurde das im produktiven System nicht erkannt!

Du hast aber schon den Pi zum Umstecken ausgeschaltet? Wenn ja, wäre ja das zweite Modul defekt?

Dann könntest Du, ich glaube das war deine ursprüngliche Intension, den Pi "testen". Also alles aus dem produktiven Pi in den Backup Pi bauen und sehen ob es läuft?!

andies · 29 Januar 2020, 07:07:08

Wie ist denn das Modul mit dem Pi verbunden: USB oder GPIO? Stimmen dort dann Adresse sowie Baudrate?

Gesendet von iPhone mit Tapatalk Pro

Otto123 · 29 Januar 2020, 08:47:53

GPIO und stimmt (Gestern um 23:14:03):

ZitatDeviceName /dev/ttyAMA0@115200

tndx · 29 Januar 2020, 13:46:52

Zitat von: Otto123 am 28 Januar 2020, 21:31:34
Das sieht komisch aus:
2020-01-28 21:09:02 D-firmware unsupported

Ist das wirklich ein HM-MOD-UART ?

Nur zur Info, die Meldung kommt, wenn auf dem Modul die Firmware-Version > 1.4.1 ist, die auch HMIP kann und wohl nicht abwärtskompatibel ist. RaspberryMatic flasht z.B. ohne Rückfrage die zur Zeit aktuelle Version 2.8.6 und macht das Funkmodul unbrauchbar für FHEM. Das kann aber aus FHEM heraus wieder auf 1.4.1 geflasht werden und wechselt nicht deswegen ständig zw. "reappeared" und "disapperead".

Udomatic · 01 Februar 2020, 07:39:13

Sorry für die späte Antwort, aber ich wurde von einemVirus lahm gelegt, es ist nicht der Corona Virus.

Zitat von: tndx am 29 Januar 2020, 13:46:52
Nur zur Info, die Meldung kommt, wenn auf dem Modul die Firmware-Version > 1.4.1 ist, die auch HMIP kann und wohl nicht abwärtskompatibel ist. RaspberryMatic flasht z.B. ohne Rückfrage die zur Zeit aktuelle Version 2.8.6 und macht das Funkmodul unbrauchbar für FHEM. Das kann aber aus FHEM heraus wieder auf 1.4.1 geflasht werden und wechselt nicht deswegen ständig zw. "reappeared" und "disapperead".

Die Antwort liefert jetzt wohl den Trugschluss. Hier zusammenfassend die Historie:

- Meinen Backup Raspberry, den ich als Testsystem verwende, habe ich über Ebay als fertiges System mit HM-Funkmodul und einer Raspberrymatic Installation neu gekauft.
- Allerdings habe ich Rasoberymatic nie getestet. Wollte ich mir aufheben, wenn ich mehr Zeit habe.
- Also habe ich die microSD Karte ausgebaut und weggelegt und eine neue leere microSD Karte mit FHEM bespielt.
- Allerdings habe ich in meinem Testsystem noch kein HMUARTLGW Modul installiert!
- Trotzdem bin ich davon ausgegangen, dass das myHMUART Funkmodul durch Raspberrrymatic auf die FW 1.4.1 geflasht wurde.

Dann stieg Otto in das Thema ein

- Sein Tipp das Funkmodul umzustecken habe ich gemacht
- Dann kam die unsupported message im Log
- Daraufhin dachte ich OK einfach schnell noch mal flashen, weil das Funkmodul scheinbar dich eine andere FW Version hat.
- Das wiederum hat nicht funktioniert mit den Standard wegen sonst hätte das Modul erkannt werden müssen, schließe ich daraus??

Meine Frage ist also, wie ich das Funkmodul flashen muss, welches unter einem Raspberrymatic initial geflasht wurde damit es in meinem Produktivsystem direkt läuft?
Ist das eine spezielle Vorgehensweise?

Update: Flashen auf FW 1.4.1. in meinem Backup System hat jetzt soweit geklappt. Readings und Log sehen gut aus.

list myHMUART Backup System

Code Auswählen

Internals:
   AssignedPeerCnt 0
   CFGFN      
   CNT        76
   Clients    :CUL_HM:
   DEF        /dev/ttyAMA0
   DEVCNT     42
   DevState   99
   DevType    UART
   DeviceName /dev/ttyAMA0@115200
   FD         7
   FUUID      5e352130-f33f-f547-0cc5-738e7816848e3f39
   LastOpen   1580540492.77229
   NAME       myHmUART
   NOTIFYDEV  global
   NR         38
   NTFY_ORDER 50-myHmUART
   PARTIAL    
   RAWMSG     050000399D861064AD360000000AA8C90B6400
   RSSI       -57
   STATE      opened
   TYPE       HMUARTLGW
   XmitOpen   1
   model      HM-MOD-UART
   msgLoadCurrent 0
   msgLoadHistory -/-/-/-/-/-/-/-/-/-/-/-
   msgLoadHistoryAbs 0/-/-/-/-/-/-/-/-/-/-/-/-
   owner      424242
   Helper:
     CreditTimer 17
     FW         66561
     Initialized 1
     AckPending:
     LastSendLen:
       3
       3
     Log:
       IDs:
     RoundTrip:
       Delay      0.00313305854797363
     loadLvl:
       lastHistory 1580540520.07151
   MatchList:
     1:CUL_HM   ^A......................
   Peers:
   READINGS:
     2020-02-01 07:02:00   D-HMIdAssigned  424242
     2020-02-01 07:02:00   D-HMIdOriginal  6BD774
     2020-02-01 07:02:00   D-firmware      1.4.1
     2020-02-01 07:02:00   D-serialNr      PEQ2214443
     2020-02-01 06:56:48   D-type          HM-MOD-UART
     2020-02-01 07:02:00   cond            ok
     2020-02-01 07:02:00   load            0
     2020-02-01 07:02:00   loadLvl         low
     2020-02-01 07:01:32   state           opened
Attributes:
   hmId       424242
   room       CUL_HM

Bau ich dann später in den produktiven PI ein. Jetzt rufen gerade die Kids...

Muss man eigentlich etwas an der hmid ändern / anpassen? hmid in produktiv und Backup System sind unterschiedlich?

Als merkt sich das Funkmodul das und muss ich dann im produktiven System die hmid anpassen?

Update: Umstecken des Funkmoduls vom Backup System in das produktive System

list sieht erstmal normal aus oder?

Code Auswählen

Internals:
   AssignedPeerCnt 42
   CNT        118
   Clients    :CUL_HM:
   DEF        /dev/ttyAMA0
   DEVCNT     118
   DevState   99
   DevType    UART
   DeviceName /dev/ttyAMA0@115200
   FD         101
   FUUID      5e30a0b2-f33f-45fc-42b5-0121b0bdfa26b41f
   LastOpen   1580553160.13766
   NAME       myHmUART
   NOTIFYDEV  global
   NR         473
   NTFY_ORDER 50-myHmUART
   PARTIAL    
   RAWMSG     04020C
   RSSI       -73
   STATE      opened
   TYPE       HMUARTLGW
   XmitOpen   1
   model      HM-MOD-UART
   msgLoadCurrent 6
   msgLoadHistory -/-/-/-/-/-/-/-/-/-/-/-
   msgLoadHistoryAbs 0/-/-/-/-/-/-/-/-/-/-/-/-
   owner      6A60EA
   owner_CCU  VCCU
   .attraggr:
   .attreocr:
     .*
   .attrminint:
   .clientArray:
     CUL_HM
   Helper:
     CreditTimer 16
     FW         66561
     Initialized 1
     SendCnt    2
     AckPending:
       102:
         cmd        08
         dst        0
         frame      FD00030066084C36
         time       1580553179.75158
       104:
         cmd        08
         dst        0
         frame      FD0003006808E835
         time       1580553198.76013
       105:
         cmd        08
         dst        0
         frame      FD00030069086E36
         time       1580553202.76633
       109:
         cmd        08
         dst        0
         frame      FD0003006D08F635
         time       1580553221.77641
       111:
         cmd        08
         dst        0
         frame      FD0003006F087A36
         time       1580553240.78694
       112:
         cmd        08
         dst        0
         frame      FD0003007008B835
         time       1580553244.79409
       114:
         cmd        08
         dst        0
         frame      FD00030072083436
         time       1580553263.80246
       116:
         cmd        08
         dst        0
         frame      FD00030074082036
         time       1580553282.81267
       117:
         cmd        08
         dst        0
         frame      FD0003007508A635
         time       1580553286.81848
     LastSendLen:
       3
       3
     Log:
       IDs:
     PendingCMD:
     RoundTrip:
       Delay      0.00320696830749512
     loadLvl:
       lastHistory 1580553163.7201
   MatchList:
     1:CUL_HM   ^A......................
   Peers:
     361649     +361649,00,00,00
     56257F     +56257F,00,00,00
     5947DC     +5947DC,00,00,00
     594C6E     +594C6E,00,00,00
     594D83     +594D83,00,00,00
     59540F     +59540F,00,00,00
     5959AD     +5959AD,00,00,00
     5D3DE9     +5D3DE9,00,00,00
     5D41A1     +5D41A1,00,00,00
     628D91     +628D91,00,00,00
     633924     +633924,00,00,00
     633926     +633926,00,00,00
     63395E     +63395E,00,00,00
     633964     +633964,00,00,00
     633A87     +633A87,00,00,00
     6359A7     +6359A7,00,00,00
     63A606     +63A606,00,00,00
     63AB1F     +63AB1F,00,00,00
     63AB56     +63AB56,00,00,00
     63AB74     +63AB74,00,00,00
     63AB7A     +63AB7A,00,00,00
     63AB99     +63AB99,00,00,00
     64AD36     +64AD36,00,00,00
     64CBA3     +64CBA3,00,00,00
     64CBB3     +64CBB3,00,00,00
     64CBD5     +64CBD5,00,00,00
     654BE7     +654BE7,00,00,00
     654D47     +654D47,00,00,00
     654DB7     +654DB7,00,00,00
     6644DC     +6644DC,00,00,00
     6738DA     +6738DA,00,00,00
     674082     +674082,00,00,00
     6740B4     +6740B4,00,00,00
     674137     +674137,00,00,00
     69CFB8     +69CFB8,00,00,00
     6A1ECE     +6A1ECE,00,00,00
     6A1ED2     +6A1ED2,00,00,00
     6A1EE5     +6A1EE5,00,00,00
     6A1EFD     +6A1EFD,00,00,00
     6B6F56     +6B6F56,00,00,00
     6C483E     +6C483E,00,00,00
     6CD39F     +6CD39F,00,00,00
   READINGS:
     2020-02-01 11:32:43   D-HMIdAssigned  6A60EA
     2020-02-01 11:32:43   D-HMIdOriginal  6BD774
     2020-02-01 11:32:43   D-firmware      1.4.1
     2020-02-01 11:32:43   D-serialNr      PEQ2214443
     2020-02-01 11:20:00   D-type          HM-MOD-UART
     2020-02-01 11:32:43   cond            ok
     2020-02-01 11:33:45   load            6
     2020-02-01 11:32:43   loadLvl         low
     2020-02-01 11:32:40   state           opened
   helper:
Attributes:
   event-on-change-reading .*
   hmId       6A60EA
   room       CUL_HM

Update: Das Funkmodul ist es dann wohl nicht. Bekomme direkt wieder die Fehler im Log

Code Auswählen

2020.02.01 11:36:26 1: /dev/ttyAMA0 disconnected, waiting to reappear (myHmUART)
2020.02.01 11:36:34 3: Setting myHmUART serial parameters to 115200,8,N,1
2020.02.01 11:36:34 1: /dev/ttyAMA0 reappeared (myHmUART)

Das ist echt frustrierend

Am Raspberry hängt noch ein ConBee2 und ein Signalduino per USB. Haben diese Geräte irgend einen Einfluss auf Homematic?

Otto123 · 01 Februar 2020, 12:06:50

Moin,

ZitatMuss man eigentlich etwas an der hmid ändern / anpassen? hmid in produktiv und Backup System sind unterschiedlich?

Die hmId ist der Dreh und Angelpunkt des Homematic Systems. Sie ist die Grundlage der Authorisierung zwischen Zentrale und den Geräten.
Warum hast Du sie unterschiedlich gesetzt?

Zum Rest bin ich ratlos. Also das Funkmodul ist es offenbar nicht.
Da es ja auch nicht massiv passiert sondern nur "ab und zu" muss es irgendein Programm / Dienst sein, der die AMA0 Schnittstelle greifen will. Da musst Du mal in Dich gehen, was da so noch läuft auf deinem System.

Du kannst doch auf dem Backup System mal ein minimal System einrichten:
raspbian-lite streng nach Wiki ohne alles weitere. hmId kannst Du gleich wie Produktivsystem machen.
https://wiki.fhem.de/wiki/Raspberry_Pi#Verwendung_UART_f.C3.BCr_Zusatzmodule
https://wiki.fhem.de/wiki/HM-MOD-RPI-PCB_HomeMatic_Funkmodul_f%C3%BCr_Raspberry_Pi#Originaler_Einsatzzweck_im_Raspberry
Wenn Du willst kannst Du meine Scripts nutzen. Damit geht das schnell und dauert nur wenige Minuten.

Gruß Otto

Udomatic · 01 Februar 2020, 12:19:27

Zitat von: Otto123 am 01 Februar 2020, 12:06:50
Moin,Die hmId ist der Dreh und Angelpunkt des Homematic Systems. Sie ist die Grundlage der Authorisierung zwischen Zentrale und den Geräten.
Warum hast Du sie unterschiedlich gesetzt?

Zum Rest bin ich ratlos. Also das Funkmodul ist es offenbar nicht.
Da es ja auch nicht massiv passiert sondern nur "ab und zu" muss es irgendein Programm / Dienst sein, der die AMA0 Schnittstelle greifen will. Da musst Du mal in Dich gehen, was da so noch läuft auf deinem System.

Das ist nur, weil ich heute Morgen schnell per Wiki Copy / Paste das Funkmodul im Backupsystem neu geflasht und eingerichtet habe.
Im Backup System mit FHEM minimal Konfiguration habe ich zumindest nicht den Fehler.

Ich habe halt jetzt keine Ahnung, wo ich ansetzen soll. Neu hinzu gekommen ist in den letzten drei Monaten primär das Thema MQTT2 Server und ein paar Devices dazu und as Echo Device Modul.

Otto123 · 01 Februar 2020, 12:42:27

FHEM blockiert zeitweise?
Hast mal nach freezes gesucht? freezemon definiert?

Udomatic · 03 Februar 2020, 09:35:27

Zitat von: Otto123 am 01 Februar 2020, 12:42:27
FHEM blockiert zeitweise?
Hast mal nach freezes gesucht? freezemon definiert?

Hallo Otto,

gestern und heute morgen ist FHEM hängen geblieben. Hatte ich bisher im Verlauf der Probleme nicht. Das Stand im Log, ich kann aber nicht ausmachen, was der Auslöser ist?

Code Auswählen

2020.02.03 08:54:07 3: mqtt2s: mqtt2s_192.168.178.49_63914/Blitzwolf-BWSHP2-01 left us (keepalive check)
2020.02.03 08:54:25 3: mqtt2s: mqtt2s_192.168.178.32_60532/Blitzwolf-BWSHP2-02 left us (keepalive check)
2020.02.03 08:54:51 1: Timeout for SYSMON_blockingCall reached, terminated process 23678
2020.02.03 08:54:52 3: mqtt2s: mqtt2s_192.168.178.24_48062/shellyswitch25-B89E2D left us (keepalive check)
2020.02.03 08:54:52 3: mqtt2s: mqtt2s_192.168.178.22_46224/shellyplug-s-040CA2 left us (keepalive check)
2020.02.03 08:55:01 3: mqtt2s: mqtt2s_192.168.178.20_46272/shellyplug-s-041439 left us (keepalive check)
2020.02.03 08:55:01 3: mqtt2s: mqtt2s_192.168.178.23_41138/shellyplug-s-7A2FD2 left us (keepalive check)
2020.02.03 08:55:08 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 23790
2020.02.03 08:55:08 2: PRESENCE (iphone_Anita) - device could not be checked (retrying in 10 seconds): Timeout: process terminated
2020.02.03 08:55:08 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 23791
2020.02.03 08:55:08 2: PRESENCE (iphone_Udo) - device could not be checked (retrying in 10 seconds): Timeout: process terminated
2020.02.03 08:55:50 1: Timeout for SYSMON_blockingCall reached, terminated process 24244
2020.02.03 08:56:03 0: SONOS0: Das Lauschen auf der Schnittstelle wurde beendet. Prozess endet nun auch...
2020.02.03 08:56:16 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 24497
2020.02.03 08:56:16 2: PRESENCE (iphone_Anita) - device could not be checked after 1 retry (retrying in 10 seconds): Timeout: process terminated
2020.02.03 08:56:16 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 24498
2020.02.03 08:56:16 2: PRESENCE (iphone_Udo) - device could not be checked after 1 retry (retrying in 10 seconds): Timeout: process terminated
2020.02.03 08:56:22 1: Timeout for FRITZBOX_Readout_Run_Web reached, terminated process 24596
2020.02.03 08:56:22 1: FRITZBOX FritzBox: Readout_Aborted.1931 Error: Timeout when reading Fritz!Box data.
2020.02.03 08:56:29 3: radinoCC1101: KeepAlive, not ok, retry = 2 -> get ping
2020.02.03 08:56:49 1: Timeout for SYSMON_blockingCall reached, terminated process 24859
2020.02.03 08:57:24 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 25203
2020.02.03 08:57:24 2: PRESENCE (iphone_Anita) - device could not be checked after 2 retries (retrying in 10 seconds): Timeout: process terminated
2020.02.03 08:57:24 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 25204
2020.02.03 08:57:24 2: PRESENCE (iphone_Udo) - device could not be checked after 2 retries (retrying in 10 seconds): Timeout: process terminated
2020.02.03 08:57:28 3: radinoCC1101: KeepAlive, not ok, retry = 3 -> get ping
2020.02.03 08:57:48 1: Timeout for SYSMON_blockingCall reached, terminated process 25443
2020.02.03 08:58:27 3: radinoCC1101: KeepAlive, not ok, retry count reached. Reset
2020.02.03 08:58:27 3: radinoCC1101: ResetDevice, radinoCC1101
2020.02.03 08:58:27 3: radinoCC1101: ResetDevice, forcing special reset for radinoCC1101 on /dev/serial/by-id/usb-Unknown_radino_CC1101-if00
2020.02.03 08:58:27 3: radinoCC1101: ResetDevice, reopen delayed for 10 second
2020.02.03 08:58:32 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 25878
2020.02.03 08:58:32 2: PRESENCE (iphone_Anita) - device could not be checked after 3 retries (resuming normal operation): Timeout: process terminated
2020.02.03 08:58:32 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 25879
2020.02.03 08:58:32 2: PRESENCE (iphone_Udo) - device could not be checked after 3 retries (resuming normal operation): Timeout: process terminated
2020.02.03 08:58:36 3: Opening radinoCC1101 device /dev/serial/by-id/usb-Unknown_radino_CC1101-if00
2020.02.03 08:58:36 3: Setting radinoCC1101 serial parameters to 57600,8,N,1
2020.02.03 08:58:36 1: radinoCC1101: DoInit, /dev/serial/by-id/usb-Unknown_radino_CC1101-if00
2020.02.03 08:58:36 1: radinoCC1101: DoInit, /dev/serial/by-id/usb-Unknown_radino_CC1101-if00
2020.02.03 08:58:36 3: radinoCC1101 device opened
2020.02.03 08:58:36 3: radinoCC1101: SimpleWrite_XQ, disable receiver (XQ)
2020.02.03 08:58:37 3: radinoCC1101: StartInit, get version, retry = 0
2020.02.03 08:58:46 3: radinoCC1101: StartInit, get version, retry = 1
2020.02.03 08:58:47 1: Timeout for SYSMON_blockingCall reached, terminated process 26062
2020.02.03 08:58:55 3: radinoCC1101: StartInit, get version, retry = 2
2020.02.03 08:59:04 3: radinoCC1101: StartInit, get version, retry = 3
2020.02.03 08:59:04 2: radinoCC1101: StartInit, retry count reached. Reset
2020.02.03 08:59:04 3: radinoCC1101: ResetDevice, radinoCC1101
2020.02.03 08:59:04 3: radinoCC1101: ResetDevice, forcing special reset for radinoCC1101 on /dev/serial/by-id/usb-Unknown_radino_CC1101-if00
2020.02.03 08:59:04 3: radinoCC1101: ResetDevice, reopen delayed for 10 second
2020.02.03 08:59:13 3: Opening radinoCC1101 device /dev/serial/by-id/usb-Unknown_radino_CC1101-if00
2020.02.03 08:59:13 3: Setting radinoCC1101 serial parameters to 57600,8,N,1
2020.02.03 08:59:13 1: radinoCC1101: DoInit, /dev/serial/by-id/usb-Unknown_radino_CC1101-if00
2020.02.03 08:59:13 1: radinoCC1101: DoInit, /dev/serial/by-id/usb-Unknown_radino_CC1101-if00
2020.02.03 08:59:13 3: radinoCC1101 device opened
2020.02.03 08:59:14 3: radinoCC1101: SimpleWrite_XQ, disable receiver (XQ)
2020.02.03 08:59:14 3: radinoCC1101: StartInit, get version, retry = 0
2020.02.03 08:59:23 3: radinoCC1101: StartInit, get version, retry = 1
2020.02.03 08:59:32 3: radinoCC1101: StartInit, get version, retry = 2
2020.02.03 08:59:41 3: radinoCC1101: StartInit, get version, retry = 3
2020.02.03 08:59:41 2: radinoCC1101: StartInit, init retry count reached. Closed
2020.02.03 08:59:41 2: radinoCC1101: CloseDevice, closed
2020.02.03 08:59:46 1: Timeout for SYSMON_blockingCall reached, terminated process 26691
2020.02.03 09:00:00 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 26800
2020.02.03 09:00:00 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 26801
2020.02.03 09:00:45 1: Timeout for SYSMON_blockingCall reached, terminated process 27337
2020.02.03 09:01:21 1: Timeout for FRITZBOX_Readout_Run_Web reached, terminated process 27711
2020.02.03 09:01:21 1: FRITZBOX FritzBox: Readout_Aborted.1931 Error: Timeout when reading Fritz!Box data.
2020.02.03 09:01:28 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 27762
2020.02.03 09:01:28 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 27763
2020.02.03 09:01:44 1: Timeout for SYSMON_blockingCall reached, terminated process 27958
2020.02.03 09:02:43 1: Timeout for SYSMON_blockingCall reached, terminated process 28572
2020.02.03 09:02:56 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 28623
2020.02.03 09:02:56 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 28624
2020.02.03 09:03:42 1: Timeout for SYSMON_blockingCall reached, terminated process 29149
2020.02.03 09:04:24 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 29515
2020.02.03 09:04:24 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 29516
2020.02.03 09:04:41 1: Timeout for SYSMON_blockingCall reached, terminated process 29768
2020.02.03 09:05:40 1: Timeout for SYSMON_blockingCall reached, terminated process 30328
2020.02.03 09:05:52 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 30473
2020.02.03 09:05:52 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 30475
2020.02.03 09:06:20 1: Timeout for FRITZBOX_Readout_Run_Web reached, terminated process 30774
2020.02.03 09:06:20 1: FRITZBOX FritzBox: Readout_Aborted.1931 Error: Timeout when reading Fritz!Box data.
2020.02.03 09:06:39 1: Timeout for SYSMON_blockingCall reached, terminated process 30957
2020.02.03 09:07:20 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 31374
2020.02.03 09:07:20 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 31375
2020.02.03 09:07:38 1: Timeout for SYSMON_blockingCall reached, terminated process 31576
2020.02.03 09:08:37 1: Timeout for SYSMON_blockingCall reached, terminated process 32193
2020.02.03 09:08:48 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 32239
2020.02.03 09:08:48 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 32240
2020.02.03 09:09:36 1: Timeout for SYSMON_blockingCall reached, terminated process 319
2020.02.03 09:10:16 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 796
2020.02.03 09:10:17 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 804
2020.02.03 09:10:35 1: Timeout for SYSMON_blockingCall reached, terminated process 1056
2020.02.03 09:11:19 1: Timeout for FRITZBOX_Readout_Run_Web reached, terminated process 1576
2020.02.03 09:11:19 1: FRITZBOX FritzBox: Readout_Aborted.1931 Error: Timeout when reading Fritz!Box data.
2020.02.03 09:11:34 1: Timeout for SYSMON_blockingCall reached, terminated process 1718
2020.02.03 09:11:44 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 1796
2020.02.03 09:11:45 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 1797
2020.02.03 09:12:33 1: Timeout for SYSMON_blockingCall reached, terminated process 2352
2020.02.03 09:13:12 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 2665
2020.02.03 09:13:13 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 2666
2020.02.03 09:13:32 1: Timeout for SYSMON_blockingCall reached, terminated process 3361
2020.02.03 09:14:31 1: Timeout for SYSMON_blockingCall reached, terminated process 3949
2020.02.03 09:14:40 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 4012
2020.02.03 09:14:41 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 4013
2020.02.03 09:15:30 1: Timeout for SYSMON_blockingCall reached, terminated process 4522
2020.02.03 09:16:08 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 4921
2020.02.03 09:16:09 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 4922
2020.02.03 09:16:18 1: Timeout for FRITZBOX_Readout_Run_Web reached, terminated process 5078
2020.02.03 09:16:18 1: FRITZBOX FritzBox: Readout_Aborted.1931 Error: Timeout when reading Fritz!Box data.
2020.02.03 09:16:29 1: Timeout for SYSMON_blockingCall reached, terminated process 5176
2020.02.03 09:17:28 1: Timeout for SYSMON_blockingCall reached, terminated process 5793
2020.02.03 09:17:36 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 5818
2020.02.03 09:17:37 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 5819
2020.02.03 09:18:27 1: Timeout for SYSMON_blockingCall reached, terminated process 6459
2020.02.03 09:19:04 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 6816
2020.02.03 09:19:05 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 6817
2020.02.03 09:19:26 1: Timeout for SYSMON_blockingCall reached, terminated process 7079
2020.02.03 09:20:25 1: Timeout for SYSMON_blockingCall reached, terminated process 7660
2020.02.03 09:20:32 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 7708
2020.02.03 09:20:33 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 7715
2020.02.03 09:21:17 1: Timeout for FRITZBOX_Readout_Run_Web reached, terminated process 8237
2020.02.03 09:21:17 1: FRITZBOX FritzBox: Readout_Aborted.1931 Error: Timeout when reading Fritz!Box data.
2020.02.03 09:21:24 1: Timeout for SYSMON_blockingCall reached, terminated process 8282
2020.02.03 09:22:00 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 8574
2020.02.03 09:22:01 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 8575
2020.02.03 09:22:23 1: Timeout for SYSMON_blockingCall reached, terminated process 8893
2020.02.03 09:23:22 1: Timeout for SYSMON_blockingCall reached, terminated process 9510
2020.02.03 09:23:29 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 9525
2020.02.03 09:23:29 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 9526
2020.02.03 09:24:21 1: Timeout for SYSMON_blockingCall reached, terminated process 11151
2020.02.03 09:24:57 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 12893
2020.02.03 09:24:57 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 12917
2020.02.03 09:25:20 1: Timeout for SYSMON_blockingCall reached, terminated process 14285
2020.02.03 09:26:16 1: Timeout for FRITZBOX_Readout_Run_Web reached, terminated process 16820
2020.02.03 09:26:16 1: FRITZBOX FritzBox: Readout_Aborted.1931 Error: Timeout when reading Fritz!Box data.
2020.02.03 09:26:19 1: Timeout for SYSMON_blockingCall reached, terminated process 16950
2020.02.03 09:26:25 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 16971
2020.02.03 09:26:25 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 16972
2020.02.03 09:26:49 1: BlockingInformParent (BlockingRegisterTelnet): Can't connect to localhost:7072: IO::Socket::INET: connect: Interrupted system call
2020.02.03 09:27:18 1: Timeout for SYSMON_blockingCall reached, terminated process 19533
2020.02.03 09:27:53 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 21041
2020.02.03 09:27:53 1: Timeout for PRESENCE_DoLocalFunctionScan reached, terminated process 21042
2020.02.03 09:28:17 1: Timeout for SYSMON_blockingCall reached, terminated process 22315

Das Presence Modul?

Otto123 · 03 Februar 2020, 09:52:31

Guten Morgen,

Dieses Verhalten vom Presence Modul kenne ich bei mir auch. Ich konnte bisher nicht ausmachen woran das liegt. Das ist zwar eine unschöne Meldung im Log aber noch kein direkter Hinweis das FHEM zu dem Zeitpunkt steht und das HMUARTLGW Modul damit ein Problem hat.

Definier mal bitte den freezemon

Code Auswählen

define freez freezemon
Der zeigt Dir ob FHEM da wirklich einfriert und für wie lange.

Gruß Otto

Udomatic · 03 Februar 2020, 09:54:32

Zitat von: Otto123 am 03 Februar 2020, 09:52:31
Guten Morgen,

Dieses Verhalten vom Presence Modul kenne ich bei mir auch. Ich konnte bisher nicht ausmachen woran das liegt. Das ist zwar eine unschöne Meldung im Log aber noch kein direkter Hinweis das FHEM zu dem Zeitpunkt steht und das HMUARTLGW Modul damit ein Problem hat.

Definier mal bitte den freezemon
Code Auswählen Erweitern
define freez freezemon
Der zeigt Dir ob FHEM da wirklich einfriert und für wie lange.

Gruß Otto

Nach define freezemon und Neustart Pi steht folgendes im Log:

Code Auswählen

2020.02.03 09:48:32 1: [Freezemon] myFreezemon: possible freeze starting at 09:48:31, delay is 1.324 possibly caused by: tmr-CUL_HM_sndIfOpen(myHmUART) tmr-CUL_HM_procQs(N/A) tmr-HMUARTLGW_CheckCmdResp(myHmUART) tmr-CODE(0x392d2c0)(__ANON__) tmr-HOMEMODE_GetUpdate(Home) tmr-CODE(0x44939c8)(__ANON__) tmr-CODE(0x5ead790)(__ANON__)

Otto123 · 03 Februar 2020, 12:41:43

Naja dass wäre ja das Problemkind an sich? Aber ich glaube solche Meldungen habe ich auch immer mal.

Zu beobachten wäre das Ganze jetzt, ob freezes im Zusammenhang mit diesen Meldungen auftauchen:

Code Auswählen

2020.02.01 11:36:26 1: /dev/ttyAMA0 disconnected, waiting to reappear (myHmUART)
2020.02.01 11:36:34 3: Setting myHmUART serial parameters to 115200,8,N,1
2020.02.01 11:36:34 1: /dev/ttyAMA0 reappeared (myHmUART)

Udomatic · 03 Februar 2020, 18:15:21

Zitat von: Otto123 am 03 Februar 2020, 12:41:43
Naja dass wäre ja das Problemkind an sich? Aber ich glaube solche Meldungen habe ich auch immer mal.

Zu beobachten wäre das Ganze jetzt, ob freezes im Zusammenhang mit diesen Meldungen auftauchen:
Code Auswählen Erweitern
2020.02.01 11:36:26 1: /dev/ttyAMA0 disconnected, waiting to reappear (myHmUART) 2020.02.01 11:36:34 3: Setting myHmUART serial parameters to 115200,8,N,1 2020.02.01 11:36:34 1: /dev/ttyAMA0 reappeared (myHmUART)

Bis jetzt nichts zu erkennen. Immer wieder der gleiche Log Fehler

Code Auswählen

2020.02.03 18:12:19 1: /dev/ttyAMA0 disconnected, waiting to reappear (myHmUART)
2020.02.03 18:12:23 3: Setting myHmUART serial parameters to 115200,8,N,1
2020.02.03 18:12:23 1: /dev/ttyAMA0 reappeared (myHmUART)

Habe schon diverse Devices gelöscht, die ich zuletzt angelegt hatte, wie Homemode, Presence, FritzBox.

Leider keine Änderung.