ModbusRS485 - RS485-TCP-Server direkt ansprechen

Begonnen von roedert, 17 November 2022, 14:01:06

Vorheriges Thema - Nächstes Thema

roedert

Ich habe im Zählerschrank einen Umsetzer von Netzwerk auf RS485 ... kann man diesen in der Definition des Modbus-Devices irgendwie direkt ansprechen?
In der Moduldoku wird nur ein lokales Device /dev/tty... erwähnt.

Falls nicht, kennt wer einen Weg, wie man dann über Umwege diese TCP-RS485-Wandler ansprechen kann?

Es handelt sich um dieses Gerät: https://www.waveshare.com/wiki/RS485_TO_ETH_(B) 

ch.eick

Zitat von: roedert am 17 November 2022, 14:01:06
Ich habe im Zählerschrank einen Umsetzer von Netzwerk auf RS485 ... kann man diesen in der Definition des Modbus-Devices irgendwie direkt ansprechen?
In der Moduldoku wird nur ein lokales Device /dev/tty... erwähnt.

Falls nicht, kennt wer einen Weg, wie man dann über Umwege diese TCP-RS485-Wandler ansprechen kann?

Es handelt sich um dieses Gerät: https://www.waveshare.com/wiki/RS485_TO_ETH_(B)
Wenn Du einen Umsetzer auf TCP hast, dann musst Du das Gerät auch mit ModBus TCP definieren.

define <name> ModbusAttr <Id> <Interval> <Address:Port> <RTU|ASCII|TCP>

VG  Christian
RPI4; Docker; CUNX; Eltako FSB61NP; SamsungTV H-Serie; Sonos; Vallox; Luxtronik; 3x FB7490; Stromzähler mit DvLIR; wunderground; Plenticore 10 mit BYD; EM410; SMAEM; Modbus TCP
Contrib: https://svn.fhem.de/trac/browser/trunk/fhem/contrib/ch.eick

StefanStrobel

Kleine Korrektur:

Modbus TCP ist nicht das gleiche wie Modbus RTU über TCP.
Wenn der Umsetzer einfach nur RS485 über TCP macht, dann ist es "RTU über TCP". Dann gibt man bei der Definition die IP-Adresse mit Port und RTU an.
Wenn er Modbus-TCP spricht, dann gibt man bei der Definition am Ende TCP an.

Gruss
   Stefan

roedert

Besten Dank für eure Antworten!
Da ich das Modbus-Device für ein ModbusSDM630M-Device (nicht im offiziellen Repository enthalten), kam ich mit dem ModbusAttr nicht weiter, da ModbusSDM630M dieses nicht als IO-Device nutzen konnte.
Über einen alten Forenbeitrag von dir habe ich die ganz einfache Lösung gefunden - ModbusSDM630M kann auch Netzwerk-Devices direkt ansprechen, was in der Hilfe von dem Modul leider nicht erwähnt war.

https://forum.fhem.de/index.php/topic,115601.msg1098670.html#msg1098670

Als Protokoll ist im DeviceServer "ModBus TCP to RTU" eingestellt, in FHEM ist das Device mit TCP definiert und es funktioniert! 



StefanStrobel

Wunderbar.

Module wie ModbusSDM630M basieren übrigens oft auf dem generischen Modbus-Modul, was zur Folge hat, dass alle Features von ModbusAttr auch im jeweiligen Modul zur Verfügung stehen.

Gruss
   Stefan

roedert

Ganz so "wunderbar" ist es wohl doch noch nicht. Ich bekomme zwar regelmäßig Daten, habe aber im Log minütlich diese Meldungen:

2022.11.18 22:36:45 3: Strom.Waermepumpe: readfn got data while EXPECT was set to idle: 00080000000f02040c000000000000000000000000
2022.11.18 22:36:46 3: Strom.Waermepumpe: readfn got data while EXPECT was set to idle: 00d8000000470204440000000000000000428c3e3300000000c28c3e2c3de2d57b00000000c2b403650000000042481dfc4310b4fe0000000042385c29434c4f5c43909a68450103353f8a8ee3


minütlich vermutlich weil das Abfrageintervall auf 60 steht.

Das Device ist so konfiguriert:
defmod Strom.Waermepumpe ModbusSDM630M 2 60 172.16.99.193:4196 TCP

StefanStrobel

Hallo roedert,

was ist an dem RS485-Bus denn alles angeschlossen?

Gruß
    Stefan

roedert

Noch ist es nur ein Testaufbau mit dem TCP-Konverter und einem SDM630 (ID 2) - verbunden mit 3 kurzen (15cm) Litzen.
Später sind es vom TCP-Konverter ca 70cm Kabel zu 2 SDM630-Devices (ID 1 und 2) nebeneinander - das wird dann ordentlich verkabelt und terminiert.

Denkst du es kann von der offenen Testverkabelung kommen? Die übertragenen Werte kommen ja regelmäßig und sind auch ok.

Als Verbindunggeschwindigkeit ist 9600-8-N-1 auf TCP-Server und den beiden SDMs eingestellt.

StefanStrobel

Die Meldung bedeutet dass das Modul Daten empfangen hat, die es gar nicht angefragt hat.
So etwas sollte eigentlich nicht möglich sein, da Dein Zähler ein Modbus-Slave ist und nur auf Anfragen eines Masters antwortet. Danach wartet ein Slave auf weitere Anfragen.
Vielleicht sehen wir mehr, wenn Du verbose für Dein Device auf 5 setzt und dann das Log postest (60 Sek von der Anfrage bis zur Fehlermeldung)

Gruß
    Stefan

roedert

2022.11.19 15:43:51 5: Strom.Waermepumpe: readFn buffer: 00870000000f02040c3e63a2633dffab673daeffaa
2022.11.19 15:43:51 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn
2022.11.19 15:43:51 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 135, dlen 15 and potential data 0c3e63a2633dffab673daeffaa
2022.11.19 15:43:51 3: Strom.Waermepumpe: readfn got data while EXPECT was set to idle: 00870000000f02040c3e63a2633dffab673daeffaa
2022.11.19 15:43:51 5: Strom.Waermepumpe: DropBuffer for ReadFn clears the reception buffer with 00870000000f02040c3e63a2633dffab673daeffaa
2022.11.19 15:43:51 5: Strom.Waermepumpe: readFn buffer: 004e000000470204444188ef8d0000000042c8fda000000000c2c322183e4c321900000000c2a02bbd000000004248018c431168730000000042398625434db06243918065450137a94287c037
2022.11.19 15:43:51 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn
2022.11.19 15:43:51 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 78, dlen 71 and potential data 444188ef8d0000000042c8fda000000000c2c322183e4c321900000000c2a02bbd000000004248018c431168730000000042398625434db06243918065450137a94287c037
2022.11.19 15:43:51 3: Strom.Waermepumpe: readfn got data while EXPECT was set to idle: 004e000000470204444188ef8d0000000042c8fda000000000c2c322183e4c321900000000c2a02bbd000000004248018c431168730000000042398625434db06243918065450137a94287c037
2022.11.19 15:43:51 5: Strom.Waermepumpe: DropBuffer for ReadFn clears the reception buffer with 004e000000470204444188ef8d0000000042c8fda000000000c2c322183e4c321900000000c2a02bbd000000004248018c431168730000000042398625434db06243918065450137a94287c037
2022.11.19 15:43:52 5: Strom.Waermepumpe: readFn buffer: 002a000000070204043eab9a03
2022.11.19 15:43:52 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn
2022.11.19 15:43:52 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 42, dlen 7 and potential data 043eab9a03
2022.11.19 15:43:52 3: Strom.Waermepumpe: readfn got data while EXPECT was set to idle: 002a000000070204043eab9a03
2022.11.19 15:43:52 5: Strom.Waermepumpe: DropBuffer for ReadFn clears the reception buffer with 002a000000070204043eab9a03
2022.11.19 15:44:01 4: Strom.Waermepumpe: GetUpdate (V4.4.11 - 5.10.2022) called from Fhem internal timer
2022.11.19 15:44:01 4: Strom.Waermepumpe: UpdateTimer called from GetUpdate with cmd next sets timer to call update function in 60.0 sec at 15:45:01.927, interval 60
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash full object list: h0 h10 h12 h14 h18 h2 h20 h22 h24 h28 h36 h42 h6 h8 h86 h88 i0 i10 i100 i102 i104 i106 i12 i14 i16 i18 i2 i20 i200 i202 i204 i206 i22 i224 i234 i236 i238 i24 i240 i242 i244 i248 i250 i254 i258 i26 i260 i262 i264 i266 i268 i28 i30 i32 i334 i336 i338 i34 i340 i342 i344 i346 i348 i350 i352 i354 i356 i358 i36 i360 i362 i38 i4 i40 i42 i46 i48 i52 i56 i6 i60 i62 i66 i70 i72 i74 i76 i78 i8 i80 i82 i84 i86
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L1__V, delay not over (delay 660, 600.242552042007 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L2__V, delay not over (delay 660, 600.242118120193 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L3__V, delay not over (delay 660, 600.241697072983 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will request i6 len 2 Current_L1__A
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will request i8 len 2 Current_L2__A
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will request i10 len 2 Current_L3__A
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L1__W, delay not over (delay 180, 119.832599163055 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L2__W, delay not over (delay 180, 119.832213163376 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L3__W, delay not over (delay 180, 119.831918001175 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L1__VA, delay not over (delay 1020, 119.831620931625 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L2__VA, delay not over (delay 1020, 119.831341981888 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L3__VA, delay not over (delay 1020, 119.831047058105 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L1__VAr, delay not over (delay 1020, 119.830726146698 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L2__VAr, delay not over (delay 1020, 119.830430030823 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L3__VAr, delay not over (delay 1020, 119.830114126205 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor_L1, delay not over (delay 1740, 119.829833984375 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor_L2, delay not over (delay 1740, 119.829551935196 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor_L3, delay not over (delay 1740, 119.82927107811 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip CosPhi_L1__grd, delay not over (delay 1380, 119.828962087631 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip CosPhi_L2__grd, delay not over (delay 1380, 119.828665971756 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip CosPhi_L3__grd, delay not over (delay 1380, 119.828269958496 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_Avr__V, delay not over (delay 420, 119.827964067459 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Avr__A, delay not over (delay 180, 119.827711105347 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Sum__A, delay not over (delay 180, 119.827455997467 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will request i52 len 2 Power_Sum__W
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_Sum__VA, delay not over (delay 1020, 59.8583500385284 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_Sum__VAr, delay not over (delay 1020, 59.8576581478119 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor, delay not over (delay 1740, 59.8569941520691 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip CosPhi__grd, delay not over (delay 1380, 59.8562660217285 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Frequency__Hz, delay not over (delay 300, 59.8556311130524 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_import__kWh, delay not over (delay 420, 59.8549740314484 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_export__kWh, delay not over (delay 420, 59.854325056076 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_import__kVArh, delay not over (delay 1020, 59.8536801338196 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_export__kVArh, delay not over (delay 1020, 59.8530280590057 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_apparent__kVAh, delay not over (delay 1020, 59.8523581027985 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Charge__kAh, delay not over (delay 660, 59.8517291545868 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will request i84 len 2 Power_Sum_demand__W
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_Max_demand__W, delay not over (delay 660, 598.555048942566 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_Sum_demand__VA, delay not over (delay 1140, 298.458189964294 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_Max_demand__VA, delay not over (delay 1140, 298.457527160645 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_N_demand__A, delay not over (delay 420, 298.456872940063 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Max_N_demand__A, delay not over (delay 780, 179.182353019714 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L1_to_L2__V, delay not over (delay 1140, 118.171713113785 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L2_to_L3__V, delay not over (delay 1140, 118.170855045319 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L3_to_L1__V, delay not over (delay 1140, 118.170032024384 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_Avr_L_to_L__V, delay not over (delay 420, 118.169213056564 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_N__A, delay not over (delay 300, 118.168365955353 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L1_N__prz, delay not over (delay 1860, 479.245393037796 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L2_N__prz, delay not over (delay 1860, 479.244562149048 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L3_N__prz, delay not over (delay 1860, 479.243710041046 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Current_L1__prz, delay not over (delay 2220, 479.242907047272 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Current_L2__prz, delay not over (delay 2220, 479.242088079453 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Current_L3__prz, delay not over (delay 2220, 479.241296052933 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_avr_LN__prz, delay not over (delay 1860, 479.240483045578 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Current_avr__prz, delay not over (delay 2220, 479.239912986755 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor_inverted, delay not over (delay 1740, 479.239654064178 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will request i258 len 2 Current_L1_demand__A
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will request i260 len 2 Current_L2_demand__A
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will request i262 len 2 Current_L3_demand__A
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Max_L1_demand__A, delay not over (delay 780, 178.432050943375 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Max_L2_demand__A, delay not over (delay 780, 178.431646108627 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Max_L3_demand__A, delay not over (delay 780, 178.431261062622 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L1_L2__prz, delay not over (delay 2220, 1739.29312109947 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L2_L3__prz, delay not over (delay 2220, 1739.29232215881 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L3_L1__prz, delay not over (delay 2220, 1739.2915520668 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_avr_LL__prz, delay not over (delay 2220, 1739.29080414772 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_total__kWh, delay not over (delay 660, 597.69283914566 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_total__kVArh, delay not over (delay 1020, 597.692562103271 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L1_import__kWh, delay not over (delay 780, 597.692286014557 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L2_import__kWh, delay not over (delay 780, 597.692016124725 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L3_import__kWh, delay not over (delay 780, 597.691749095917 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L1_export__kWh, delay not over (delay 780, 597.69148516655 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L2_export__kWh, delay not over (delay 780, 597.691236972809 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L3_export__kWh, delay not over (delay 780, 597.690984010696 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L1_total__kWh, delay not over (delay 660, 597.690711975098 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L2_total__kWh, delay not over (delay 660, 597.690451145172 passed)
2022.11.19 15:44:01 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L3_total__kWh, delay not over (delay 660, 597.690187931061 passed)
2022.11.19 15:44:01 4: Strom.Waermepumpe: CombineUpdateHash objHash keys before combine: i10,i262,i52,i8,i260,i84,i258,i6
2022.11.19 15:44:01 5: Strom.Waermepumpe: CombineUpdateHash tries to combine read commands
2022.11.19 15:44:01 5: Strom.Waermepumpe: CombineUpdateHash combine i6 len 2 Current_L1__A with i8 len 2 Current_L2__A to span 4, drop read for i8
2022.11.19 15:44:01 5: Strom.Waermepumpe: CombineUpdateHash combine i6 len 2 Current_L1__A with i10 len 2 Current_L3__A to span 6, drop read for i10
2022.11.19 15:44:01 5: Strom.Waermepumpe: CombineUpdateHash cant combine i6 len 2 Current_L1__A with i52 len 2 Power_Sum__W, span 48 would be bigger than max 40
2022.11.19 15:44:01 5: Strom.Waermepumpe: CombineUpdateHash combine i52 len 2 Power_Sum__W with i84 len 2 Power_Sum_demand__W to span 34, drop read for i84
2022.11.19 15:44:01 5: Strom.Waermepumpe: CombineUpdateHash cant combine i52 len 2 Power_Sum__W with i258 len 2 Current_L1_demand__A, span 208 would be bigger than max 40
2022.11.19 15:44:01 5: Strom.Waermepumpe: CombineUpdateHash combine i258 len 2 Current_L1_demand__A with i260 len 2 Current_L2_demand__A to span 4, drop read for i260
2022.11.19 15:44:01 5: Strom.Waermepumpe: CombineUpdateHash combine i258 len 2 Current_L1_demand__A with i262 len 2 Current_L3_demand__A to span 6, drop read for i262
2022.11.19 15:44:01 5: Strom.Waermepumpe: CombineUpdateHash keys are now i52,i258,i6
2022.11.19 15:44:01 4: Strom.Waermepumpe: GetUpdate will now create requests for i6 len 6 (combined i6 len 2 Current_L1__A with i8 len 2 Current_L2__A and i10 len 2 Current_L3__A), i52 len 34 (combined i52 len 2 Power_Sum__W with i84 len 2 Power_Sum_demand__W), i258 len 6 (combined i258 len 2 Current_L1_demand__A with i260 len 2 Current_L2_demand__A and i262 len 2 Current_L3_demand__A)
2022.11.19 15:44:01 4: Strom.Waermepumpe: DoRequest called from GetUpdate created new request, read buffer empty, id 2, fCode 4, tid 42,
request: id 2, read fc 4 i6, len 6, tid 126, master device Strom.Waermepumpe, reading Current_L1__A (getUpdate for combined i6 len 2 Current_L1__A with i8 len 2 Current_L2__A and i10 len 2 Current_L3__A)
2022.11.19 15:44:01 5: Strom.Waermepumpe: QueueRequest called from DoRequest with i6, qlen 0 from master Strom.Waermepumpe through io device Strom.Waermepumpe
2022.11.19 15:44:01 5: Strom.Waermepumpe: StartQueueTimer called from QueueRequest sets internal timer to process queue in 0.000 seconds
2022.11.19 15:44:01 4: Strom.Waermepumpe: DoRequest called from GetUpdate created new request, read buffer empty, id 2, fCode 4, tid 42,
request: id 2, read fc 4 i52, len 34, tid 172, master device Strom.Waermepumpe, reading Power_Sum__W (getUpdate for combined i52 len 2 Power_Sum__W with i84 len 2 Power_Sum_demand__W)
2022.11.19 15:44:01 5: Strom.Waermepumpe: QueueRequest called from DoRequest with i52, qlen 1 from master Strom.Waermepumpe through io device Strom.Waermepumpe
2022.11.19 15:44:01 4: Strom.Waermepumpe: DoRequest called from GetUpdate created new request, read buffer empty, id 2, fCode 4, tid 42,
request: id 2, read fc 4 i258, len 6, tid 99, master device Strom.Waermepumpe, reading Current_L1_demand__A (getUpdate for combined i258 len 2 Current_L1_demand__A with i260 len 2 Current_L2_demand__A and i262 len 2 Current_L3_demand__A)
2022.11.19 15:44:01 5: Strom.Waermepumpe: QueueRequest called from DoRequest with i258, qlen 2 from master Strom.Waermepumpe through io device Strom.Waermepumpe
2022.11.19 15:44:01 5: Strom.Waermepumpe: ProcessRequestQueue called from Fhem internal timer as queue:Strom.Waermepumpe, qlen 3, request: request: id 2, read fc 4 i6, len 6, tid 126, master device Strom.Waermepumpe, reading Current_L1__A (getUpdate for combined i6 len 2 Current_L1__A with i8 len 2 Current_L2__A and i10 len 2 Current_L3__A), queued 0.01 secs ago
2022.11.19 15:44:01 5: Strom.Waermepumpe: checkDelays clientSwitchDelay is not relevant
2022.11.19 15:44:01 5: Strom.Waermepumpe: checkDelays sendDelay, last send to same device was 60.029 secs ago, required delay is 0.7
2022.11.19 15:44:01 5: Strom.Waermepumpe: checkDelays commDelay, last communication with same device was 9.369 secs ago, required delay is 0.7
2022.11.19 15:44:01 5: Strom.Waermepumpe: checkDelays busDelayRead, last activity on bus was 9.369 secs ago, required delay is 0
2022.11.19 15:44:01 4: Strom.Waermepumpe: ProcessRequestQueue (V4.4.11 - 5.10.2022) qlen 3, sending 007e00000006020400060006 via 172.16.99.193:4196, read buffer empty, id 2, fCode 4, tid 42,
request: id 2, read fc 4 i6, len 6, tid 126, master device Strom.Waermepumpe, reading Current_L1__A (getUpdate for combined i6 len 2 Current_L1__A with i8 len 2 Current_L2__A and i10 len 2 Current_L3__A), queued 0.01 secs ago
2022.11.19 15:44:01 5: Strom.Waermepumpe: Send called from ProcessRequestQueue
2022.11.19 15:44:01 5: DevIo_SimpleWrite Strom.Waermepumpe: 007e00000006020400060006
2022.11.19 15:44:01 5: Strom.Waermepumpe: StartQueueTimer called from ProcessRequestQueue sets internal timer to process queue in 1.000 seconds
2022.11.19 15:44:02 5: Strom.Waermepumpe: readFn buffer: 007e0000000f02040c3e627e183dfc3b333db0771a
2022.11.19 15:44:02 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn protocol TCP expecting id 2
2022.11.19 15:44:02 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 126, dlen 15 and potential data 0c3e627e183dfc3b333db0771a
2022.11.19 15:44:02 5: Strom.Waermepumpe: HandleResponse called from ReadFn
2022.11.19 15:44:02 5: Strom.Waermepumpe: ParseResponse called from HandleResponse
2022.11.19 15:44:02 5: Strom.Waermepumpe: now parsing response data objects, master is Strom.Waermepumpe relay is undefined
2022.11.19 15:44:02 5: Strom.Waermepumpe: ParseDataString called from HandleResponse with data hex 3e627e183dfc3b333db0771a, type i, adr 6, op read
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString called from ParseDataString with data hex 3e627e183dfc3b333db0771a, type i, adr 6, valuesLen 6, op read
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects called from ParseDataString with objList i6,i8,i10
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects sortedList i6,i8,i10
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 3e627e18 with f> to 0.221184134483337
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.221184134483337 with format %.2f, result is 0.22
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.22 to Current_L1__A
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 3dfc3b33 with f> to 0.123159788548946
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.123159788548946 with format %.2f, result is 0.12
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.12 to Current_L2__A
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 3db0771a with f> to 0.0861646682024002
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.0861646682024002 with format %.2f, result is 0.09
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.09 to Current_L3__A
2022.11.19 15:44:02 5: Strom.Waermepumpe: ParseDataString created 3 readings
2022.11.19 15:44:02 4: Strom.Waermepumpe: HandleResponse done, current frame / read buffer: 007e0000000f02040c3e627e183dfc3b333db0771a, id 2, fCode 4, tid 126,
request: id 2, read fc 4 i6, len 6, tid 126, master device Strom.Waermepumpe, reading Current_L1__A (getUpdate for combined i6 len 2 Current_L1__A with i8 len 2 Current_L2__A and i10 len 2 Current_L3__A), queued 0.07 secs ago, sent 0.06 secs ago,
2022.11.19 15:44:02 5: Strom.Waermepumpe: ResetExpect for HandleResponse from response to idle
2022.11.19 15:44:02 5: Strom.Waermepumpe: StartQueueTimer called from HandleResponse sets internal timer to process queue in 0.000 seconds
2022.11.19 15:44:02 5: Strom.Waermepumpe: DropFrame called from ReadFn - drop 007e0000000f02040c3e627e183dfc3b333db0771a
2022.11.19 15:44:02 5: Strom.Waermepumpe: ProcessRequestQueue called from Fhem internal timer as queue:Strom.Waermepumpe, qlen 2, request: request: id 2, read fc 4 i52, len 34, tid 172, master device Strom.Waermepumpe, reading Power_Sum__W (getUpdate for combined i52 len 2 Power_Sum__W with i84 len 2 Power_Sum_demand__W), queued 0.08 secs ago
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays busDelayRead, last activity on bus was 0.011 secs ago, required delay is 0
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays clientSwitchDelay is not relevant
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays sendDelay, last send to same device was 0.064 secs ago, required delay is 0.7
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays commDelay, last communication with same device was 0.011 secs ago, required delay is 0.7
2022.11.19 15:44:02 4: Strom.Waermepumpe: checkDelays found commDelay not over, set timer to try again in 0.689
2022.11.19 15:44:02 5: Strom.Waermepumpe: ProcessRequestQueue called from Fhem internal timer as queue:Strom.Waermepumpe, qlen 2, request: request: id 2, read fc 4 i52, len 34, tid 172, master device Strom.Waermepumpe, reading Power_Sum__W (getUpdate for combined i52 len 2 Power_Sum__W with i84 len 2 Power_Sum_demand__W), queued 0.77 secs ago
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays commDelay, last communication with same device was 0.705 secs ago, required delay is 0.7
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays clientSwitchDelay is not relevant
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays sendDelay, last send to same device was 0.758 secs ago, required delay is 0.7
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays busDelayRead, last activity on bus was 0.705 secs ago, required delay is 0
2022.11.19 15:44:02 4: Strom.Waermepumpe: ProcessRequestQueue (V4.4.11 - 5.10.2022) qlen 2, sending 00ac00000006020400340022 via 172.16.99.193:4196, read buffer empty,
request: id 2, read fc 4 i52, len 34, tid 172, master device Strom.Waermepumpe, reading Power_Sum__W (getUpdate for combined i52 len 2 Power_Sum__W with i84 len 2 Power_Sum_demand__W), queued 0.77 secs ago
2022.11.19 15:44:02 5: Strom.Waermepumpe: Send called from ProcessRequestQueue
2022.11.19 15:44:02 5: DevIo_SimpleWrite Strom.Waermepumpe: 00ac00000006020400340022
2022.11.19 15:44:02 5: Strom.Waermepumpe: StartQueueTimer called from ProcessRequestQueue sets internal timer to process queue in 1.000 seconds
2022.11.19 15:44:02 5: Strom.Waermepumpe: readFn buffer: 00ac0000004702044441898e200000000042c94e1600000000c2c36e053e4d2cd400000000c2a00d440000000042480ba5431168b40000000042398625434db0a443918091450137a94287c037
2022.11.19 15:44:02 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn protocol TCP expecting id 2
2022.11.19 15:44:02 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 172, dlen 71 and potential data 4441898e200000000042c94e1600000000c2c36e053e4d2cd400000000c2a00d440000000042480ba5431168b40000000042398625434db0a443918091450137a94287c037
2022.11.19 15:44:02 5: Strom.Waermepumpe: HandleResponse called from ReadFn
2022.11.19 15:44:02 5: Strom.Waermepumpe: ParseResponse called from HandleResponse
2022.11.19 15:44:02 5: Strom.Waermepumpe: now parsing response data objects, master is Strom.Waermepumpe relay is undefined
2022.11.19 15:44:02 5: Strom.Waermepumpe: ParseDataString called from HandleResponse with data hex 41898e200000000042c94e1600000000c2c36e053e4d2cd400000000c2a00d440000000042480ba5431168b40000000042398625434db0a443918091450137a94287c037, type i, adr 52, op read
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString called from ParseDataString with data hex 41898e200000000042c94e1600000000c2c36e053e4d2cd400000000c2a00d440000000042480ba5431168b40000000042398625434db0a443918091450137a94287c037, type i, adr 52, valuesLen 34, op read
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString has no information about handling i54
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString has no information about handling i55
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString has no information about handling i58
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString has no information about handling i59
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString has no information about handling i64
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString has no information about handling i65
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString has no information about handling i68
2022.11.19 15:44:02 5: Strom.Waermepumpe: SplitDataString has no information about handling i69
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects called from ParseDataString with objList i52,i56,i60,i62,i66,i70,i72,i74,i76,i78,i80,i82,i84
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects sortedList i52,i56,i60,i62,i66,i70,i72,i74,i76,i78,i80,i82,i84
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 41898e20 with f> to 17.1943969726562
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 17.1943969726562 with format %.1f, result is 17.2
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 17.2 to Power_Sum__W
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 42c94e16 with f> to 100.65251159668
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 100.65251159668 with format %.1f, result is 100.7
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 100.7 to Power_Sum__VA
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked c2c36e05 with f> to -97.7148818969727
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats -97.7148818969727 with format %.1f, result is -97.7
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value -97.7 to Power_Sum__VAr
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 3e4d2cd4 with f> to 0.200366318225861
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.200366318225861 with format %.1f, result is 0.2
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.2 to PowerFactor
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked c2a00d44 with f> to -80.0259094238281
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats -80.0259094238281 with format %.1f, result is -80.0
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value -80.0 to CosPhi__grd
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 42480ba5 with f> to 50.0113716125488
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 50.0113716125488 with format %.1f, result is 50.0
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 50.0 to Frequency__Hz
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 431168b4 with f> to 145.408996582031
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 145.408996582031 with format %.3f, result is 145.409
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 145.409 to Energy_import__kWh
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 00000000 with f> to 0
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0 with format %.3f, result is 0.000
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.000 to Energy_export__kWh
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 42398625 with f> to 46.3810005187988
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 46.3810005187988 with format %.3f, result is 46.381
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 46.381 to Energy_import__kVArh
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 434db0a4 with f> to 205.690002441406
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 205.690002441406 with format %.3f, result is 205.690
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 205.690 to Energy_export__kVArh
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 43918091 with f> to 291.004425048828
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 291.004425048828 with format %.3f, result is 291.004
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 291.004 to Energy_apparent__kVAh
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 450137a9 with f> to 2067.47875976562
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 2067.47875976562 with format %.3f, result is 2067.479
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 2067.479 to Charge__kAh
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:02 5: Strom.Waermepumpe: CreateDataObjects unpacked 4287c037 with f> to 67.8754196166992
2022.11.19 15:44:02 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 67.8754196166992 with format %.1f, result is 67.9
2022.11.19 15:44:02 4: Strom.Waermepumpe: CreateDataObjects assigns value 67.9 to Power_Sum_demand__W
2022.11.19 15:44:02 2: NOTIFY Display_nfy.Strom.Heizung (Strom.Waermepumpe:Power_Sum__W: 17.2)
2022.11.19 15:44:02 5: Strom.Waermepumpe: ParseDataString created 13 readings
2022.11.19 15:44:02 4: Strom.Waermepumpe: HandleResponse done, current frame / read buffer: 00ac0000004702044441898e200000000042c94e1600000000c2c36e053e4d2cd400000000c2a00d440000000042480ba5431168b40000000042398625434db0a443918091450137a94287c037, id 2, fCode 4, tid 172,
request: id 2, read fc 4 i52, len 34, tid 172, master device Strom.Waermepumpe, reading Power_Sum__W (getUpdate for combined i52 len 2 Power_Sum__W with i84 len 2 Power_Sum_demand__W), queued 0.95 secs ago, sent 0.18 secs ago,
2022.11.19 15:44:02 5: Strom.Waermepumpe: ResetExpect for HandleResponse from response to idle
2022.11.19 15:44:02 5: Strom.Waermepumpe: StartQueueTimer called from HandleResponse sets internal timer to process queue in 0.000 seconds
2022.11.19 15:44:02 5: Strom.Waermepumpe: DropFrame called from ReadFn - drop 00ac0000004702044441898e200000000042c94e1600000000c2c36e053e4d2cd400000000c2a00d440000000042480ba5431168b40000000042398625434db0a443918091450137a94287c037
2022.11.19 15:44:02 5: Strom.Waermepumpe: ProcessRequestQueue called from Fhem internal timer as queue:Strom.Waermepumpe, qlen 1, request: request: id 2, read fc 4 i258, len 6, tid 99, master device Strom.Waermepumpe, reading Current_L1_demand__A (getUpdate for combined i258 len 2 Current_L1_demand__A with i260 len 2 Current_L2_demand__A and i262 len 2 Current_L3_demand__A), queued 0.96 secs ago
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays busDelayRead, last activity on bus was 0.049 secs ago, required delay is 0
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays commDelay, last communication with same device was 0.049 secs ago, required delay is 0.7
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays sendDelay, last send to same device was 0.184 secs ago, required delay is 0.7
2022.11.19 15:44:02 5: Strom.Waermepumpe: checkDelays clientSwitchDelay is not relevant
2022.11.19 15:44:02 4: Strom.Waermepumpe: checkDelays found commDelay not over, set timer to try again in 0.651
2022.11.19 15:44:03 5: Strom.Waermepumpe: ProcessRequestQueue called from Fhem internal timer as queue:Strom.Waermepumpe, qlen 1, request: request: id 2, read fc 4 i258, len 6, tid 99, master device Strom.Waermepumpe, reading Current_L1_demand__A (getUpdate for combined i258 len 2 Current_L1_demand__A with i260 len 2 Current_L2_demand__A and i262 len 2 Current_L3_demand__A), queued 1.61 secs ago
2022.11.19 15:44:03 5: Strom.Waermepumpe: checkDelays busDelayRead, last activity on bus was 0.703 secs ago, required delay is 0
2022.11.19 15:44:03 5: Strom.Waermepumpe: checkDelays clientSwitchDelay is not relevant
2022.11.19 15:44:03 5: Strom.Waermepumpe: checkDelays sendDelay, last send to same device was 0.838 secs ago, required delay is 0.7
2022.11.19 15:44:03 5: Strom.Waermepumpe: checkDelays commDelay, last communication with same device was 0.703 secs ago, required delay is 0.7
2022.11.19 15:44:03 4: Strom.Waermepumpe: ProcessRequestQueue (V4.4.11 - 5.10.2022) qlen 1, sending 006300000006020401020006 via 172.16.99.193:4196, read buffer empty,
request: id 2, read fc 4 i258, len 6, tid 99, master device Strom.Waermepumpe, reading Current_L1_demand__A (getUpdate for combined i258 len 2 Current_L1_demand__A with i260 len 2 Current_L2_demand__A and i262 len 2 Current_L3_demand__A), queued 1.61 secs ago
2022.11.19 15:44:03 5: Strom.Waermepumpe: Send called from ProcessRequestQueue
2022.11.19 15:44:03 5: DevIo_SimpleWrite Strom.Waermepumpe: 006300000006020401020006
2022.11.19 15:44:03 5: Strom.Waermepumpe: readFn buffer: 00630000000f02040c3ee077f13dff9a1a3dae1a6a
2022.11.19 15:44:03 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn protocol TCP expecting id 2
2022.11.19 15:44:03 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 99, dlen 15 and potential data 0c3ee077f13dff9a1a3dae1a6a
2022.11.19 15:44:03 5: Strom.Waermepumpe: HandleResponse called from ReadFn
2022.11.19 15:44:03 5: Strom.Waermepumpe: ParseResponse called from HandleResponse
2022.11.19 15:44:03 5: Strom.Waermepumpe: now parsing response data objects, master is Strom.Waermepumpe relay is undefined
2022.11.19 15:44:03 5: Strom.Waermepumpe: ParseDataString called from HandleResponse with data hex 3ee077f13dff9a1a3dae1a6a, type i, adr 258, op read
2022.11.19 15:44:03 5: Strom.Waermepumpe: SplitDataString called from ParseDataString with data hex 3ee077f13dff9a1a3dae1a6a, type i, adr 258, valuesLen 6, op read
2022.11.19 15:44:03 5: Strom.Waermepumpe: CreateDataObjects called from ParseDataString with objList i258,i260,i262
2022.11.19 15:44:03 5: Strom.Waermepumpe: CreateDataObjects sortedList i258,i260,i262
2022.11.19 15:44:03 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:03 5: Strom.Waermepumpe: CreateDataObjects unpacked 3ee077f1 with f> to 0.438415080308914
2022.11.19 15:44:03 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.438415080308914 with format %.2f, result is 0.44
2022.11.19 15:44:03 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.44 to Current_L1_demand__A
2022.11.19 15:44:03 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:03 5: Strom.Waermepumpe: CreateDataObjects unpacked 3dff9a1a with f> to 0.124805644154549
2022.11.19 15:44:03 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.124805644154549 with format %.2f, result is 0.12
2022.11.19 15:44:03 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.12 to Current_L2_demand__A
2022.11.19 15:44:03 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 15:44:03 5: Strom.Waermepumpe: CreateDataObjects unpacked 3dae1a6a with f> to 0.0850113183259964
2022.11.19 15:44:03 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.0850113183259964 with format %.2f, result is 0.09
2022.11.19 15:44:03 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.09 to Current_L3_demand__A
2022.11.19 15:44:03 5: Strom.Waermepumpe: ParseDataString created 3 readings
2022.11.19 15:44:03 4: Strom.Waermepumpe: HandleResponse done, current frame / read buffer: 00630000000f02040c3ee077f13dff9a1a3dae1a6a, id 2, fCode 4, tid 99,
request: id 2, read fc 4 i258, len 6, tid 99, master device Strom.Waermepumpe, reading Current_L1_demand__A (getUpdate for combined i258 len 2 Current_L1_demand__A with i260 len 2 Current_L2_demand__A and i262 len 2 Current_L3_demand__A), queued 1.68 secs ago, sent 0.07 secs ago,
2022.11.19 15:44:03 5: Strom.Waermepumpe: ResetExpect for HandleResponse from response to idle
2022.11.19 15:44:03 5: Strom.Waermepumpe: DropFrame called from ReadFn - drop 00630000000f02040c3ee077f13dff9a1a3dae1a6a

StefanStrobel

Ein bisschen länger wäre hilfreich.
So sehe ich die Fehlermeldung und danach einen korrekten Lesezyklus. Interessant sind aber die Aktivitäten vor der Fehlermeldung.

Gruß
    Stefan

roedert

#11
Ich dachte eigentlich, ich hätte alle Meldungen einen Leseszyklus erwischt, danach ist wieder für 1min Ruhe.

Hier noch ein Versuch:


2022.11.19 17:39:05 4: Strom.Waermepumpe: GetUpdate (V4.4.11 - 5.10.2022) called from Fhem internal timer
2022.11.19 17:39:05 4: Strom.Waermepumpe: UpdateTimer called from GetUpdate with cmd next sets timer to call update function in 60.0 sec at 17:40:05.505, interval 60
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash full object list: h0 h10 h12 h14 h18 h2 h20 h22 h24 h28 h36 h42 h6 h8 h86 h88 i0 i10 i100 i102 i104 i106 i12 i14 i16 i18 i2 i20 i200 i202 i204 i206 i22 i224 i234 i236 i238 i24 i240 i242 i244 i248 i250 i254 i258 i26 i260 i262 i264 i266 i268 i28 i30 i32 i334 i336 i338 i34 i340 i342 i344 i346 i348 i350 i352 i354 i356 i358 i36 i360 i362 i38 i4 i40 i42 i46 i48 i52 i56 i6 i60 i62 i66 i70 i72 i74 i76 i78 i8 i80 i82 i84 i86
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L1__V, delay not over (delay 660, 180.042117118835 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L2__V, delay not over (delay 660, 180.04181599617 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L3__V, delay not over (delay 660, 180.041547060013 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_L1__A, delay not over (delay 300, 240.050017118454 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_L2__A, delay not over (delay 300, 240.049707174301 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_L3__A, delay not over (delay 300, 240.049426078796 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L1__W, delay not over (delay 180, 59.8270130157471 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L2__W, delay not over (delay 180, 59.8264050483704 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L3__W, delay not over (delay 180, 59.8258430957794 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L1__VA, delay not over (delay 1020, 59.8252902030945 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L2__VA, delay not over (delay 1020, 59.8247320652008 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L3__VA, delay not over (delay 1020, 59.8241851329803 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L1__VAr, delay not over (delay 1020, 59.823625087738 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L2__VAr, delay not over (delay 1020, 59.8230791091919 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_L3__VAr, delay not over (delay 1020, 59.8225471973419 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor_L1, delay not over (delay 1740, 59.8219921588898 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor_L2, delay not over (delay 1740, 59.8214311599731 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor_L3, delay not over (delay 1740, 59.8208901882172 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip CosPhi_L1__grd, delay not over (delay 1380, 59.8202991485596 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip CosPhi_L2__grd, delay not over (delay 1380, 59.8197522163391 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip CosPhi_L3__grd, delay not over (delay 1380, 59.8190240859985 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_Avr__V, delay not over (delay 420, 59.8184380531311 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will request i46 len 2 Current_Avr__A
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will request i48 len 2 Current_Sum__A
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will request i52 len 2 Power_Sum__W
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_Sum__VA, delay not over (delay 1020, 58.9859781265259 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_Sum__VAr, delay not over (delay 1020, 58.985160112381 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor, delay not over (delay 1740, 58.9843590259552 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip CosPhi__grd, delay not over (delay 1380, 58.9835381507874 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Frequency__Hz, delay not over (delay 300, 58.9827220439911 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_import__kWh, delay not over (delay 420, 58.9819190502167 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_export__kWh, delay not over (delay 420, 58.9811120033264 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_import__kVArh, delay not over (delay 1020, 58.9803111553192 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_export__kVArh, delay not over (delay 1020, 58.9795122146606 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_apparent__kVAh, delay not over (delay 1020, 58.9787080287933 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Charge__kAh, delay not over (delay 660, 58.977860212326 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will request i84 len 2 Power_Sum_demand__W
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Power_Max_demand__W, delay not over (delay 660, 479.218866109848 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will request i100 len 2 Power_Sum_demand__VA
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will request i102 len 2 Power_Max_demand__VA
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_N_demand__A, delay not over (delay 420, 238.379412174225 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Max_N_demand__A, delay not over (delay 780, 358.699713230133 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L1_to_L2__V, delay not over (delay 1140, 1019.61055922508 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L2_to_L3__V, delay not over (delay 1140, 1019.61003112793 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_L3_to_L1__V, delay not over (delay 1140, 1019.60970616341 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Voltage_Avr_L_to_L__V, delay not over (delay 420, 237.534450054169 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_N__A, delay not over (delay 300, 119.04722905159 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L1_N__prz, delay not over (delay 1860, 119.046683073044 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L2_N__prz, delay not over (delay 1860, 119.046131134033 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L3_N__prz, delay not over (delay 1860, 119.045549154282 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Current_L1__prz, delay not over (delay 2220, 119.045025110245 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Current_L2__prz, delay not over (delay 2220, 119.044299125671 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Current_L3__prz, delay not over (delay 2220, 119.043786048889 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_avr_LN__prz, delay not over (delay 1860, 119.043256998062 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Current_avr__prz, delay not over (delay 2220, 119.042723178864 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip PowerFactor_inverted, delay not over (delay 1740, 119.042205095291 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_L1_demand__A, delay not over (delay 420, 119.04168009758 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_L2_demand__A, delay not over (delay 420, 119.041139125824 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_L3_demand__A, delay not over (delay 420, 119.040621042252 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Max_L1_demand__A, delay not over (delay 780, 299.220447063446 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Max_L2_demand__A, delay not over (delay 780, 299.219619035721 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Current_Max_L3_demand__A, delay not over (delay 780, 299.218779087067 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L1_L2__prz, delay not over (delay 2220, 1799.09191203117 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L2_L3__prz, delay not over (delay 2220, 1799.09163212776 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_L3_L1__prz, delay not over (delay 2220, 1799.09138512611 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip THD_Voltage_avr_LL__prz, delay not over (delay 2220, 1799.09113907814 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_total__kWh, delay not over (delay 660, 298.359850168228 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_total__kVArh, delay not over (delay 1020, 298.359096050262 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L1_import__kWh, delay not over (delay 780, 298.358313083649 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L2_import__kWh, delay not over (delay 780, 298.357571125031 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L3_import__kWh, delay not over (delay 780, 298.357149124146 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L1_export__kWh, delay not over (delay 780, 298.356739997864 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L2_export__kWh, delay not over (delay 780, 298.356315135956 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L3_export__kWh, delay not over (delay 780, 298.355902194977 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L1_total__kWh, delay not over (delay 660, 298.355470180511 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L2_total__kWh, delay not over (delay 660, 298.355050086975 passed)
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateUpdateHash will skip Energy_L3_total__kWh, delay not over (delay 660, 298.354639053345 passed)
2022.11.19 17:39:05 4: Strom.Waermepumpe: CombineUpdateHash objHash keys before combine: i100,i46,i102,i84,i48,i52
2022.11.19 17:39:05 5: Strom.Waermepumpe: CombineUpdateHash tries to combine read commands
2022.11.19 17:39:05 5: Strom.Waermepumpe: CombineUpdateHash combine i46 len 2 Current_Avr__A with i48 len 2 Current_Sum__A to span 4, drop read for i48
2022.11.19 17:39:05 5: Strom.Waermepumpe: CombineUpdateHash combine i46 len 2 Current_Avr__A with i52 len 2 Power_Sum__W to span 8, drop read for i52
2022.11.19 17:39:05 5: Strom.Waermepumpe: CombineUpdateHash combine i46 len 2 Current_Avr__A with i84 len 2 Power_Sum_demand__W to span 40, drop read for i84
2022.11.19 17:39:05 5: Strom.Waermepumpe: CombineUpdateHash cant combine i46 len 2 Current_Avr__A with i100 len 2 Power_Sum_demand__VA, span 56 would be bigger than max 40
2022.11.19 17:39:05 5: Strom.Waermepumpe: CombineUpdateHash combine i100 len 2 Power_Sum_demand__VA with i102 len 2 Power_Max_demand__VA to span 4, drop read for i102
2022.11.19 17:39:05 5: Strom.Waermepumpe: CombineUpdateHash keys are now i100,i46
2022.11.19 17:39:05 4: Strom.Waermepumpe: GetUpdate will now create requests for i46 len 40 (combined i46 len 2 Current_Avr__A with i48 len 2 Current_Sum__A and i52 len 2 Power_Sum__W and i84 len 2 Power_Sum_demand__W), i100 len 4 (combined i100 len 2 Power_Sum_demand__VA with i102 len 2 Power_Max_demand__VA)
2022.11.19 17:39:05 4: Strom.Waermepumpe: DoRequest called from GetUpdate created new request, read buffer empty, id 2, fCode 4, tid 70,
request: id 2, read fc 4 i46, len 40, tid 206, master device Strom.Waermepumpe, reading Current_Avr__A (getUpdate for combined i46 len 2 Current_Avr__A with i48 len 2 Current_Sum__A and i52 len 2 Power_Sum__W and i84 len 2 Power_Sum_demand__W)
2022.11.19 17:39:05 5: Strom.Waermepumpe: QueueRequest called from DoRequest with i46, qlen 0 from master Strom.Waermepumpe through io device Strom.Waermepumpe
2022.11.19 17:39:05 5: Strom.Waermepumpe: StartQueueTimer called from QueueRequest sets internal timer to process queue in 0.000 seconds
2022.11.19 17:39:05 4: Strom.Waermepumpe: DoRequest called from GetUpdate created new request, read buffer empty, id 2, fCode 4, tid 70,
request: id 2, read fc 4 i100, len 4, tid 62, master device Strom.Waermepumpe, reading Power_Sum_demand__VA (getUpdate for combined i100 len 2 Power_Sum_demand__VA with i102 len 2 Power_Max_demand__VA)
2022.11.19 17:39:05 5: Strom.Waermepumpe: QueueRequest called from DoRequest with i100, qlen 1 from master Strom.Waermepumpe through io device Strom.Waermepumpe
2022.11.19 17:39:05 5: Strom.Waermepumpe: ProcessRequestQueue called from Fhem internal timer as queue:Strom.Waermepumpe, qlen 2, request: request: id 2, read fc 4 i46, len 40, tid 206, master device Strom.Waermepumpe, reading Current_Avr__A (getUpdate for combined i46 len 2 Current_Avr__A with i48 len 2 Current_Sum__A and i52 len 2 Power_Sum__W and i84 len 2 Power_Sum_demand__W), queued 0.03 secs ago
2022.11.19 17:39:05 5: Strom.Waermepumpe: checkDelays busDelayRead, last activity on bus was 46.171 secs ago, required delay is 0
2022.11.19 17:39:05 5: Strom.Waermepumpe: checkDelays commDelay, last communication with same device was 46.171 secs ago, required delay is 0.7
2022.11.19 17:39:05 5: Strom.Waermepumpe: checkDelays clientSwitchDelay is not relevant
2022.11.19 17:39:05 5: Strom.Waermepumpe: checkDelays sendDelay, last send to same device was 59.170 secs ago, required delay is 0.7
2022.11.19 17:39:05 4: Strom.Waermepumpe: ProcessRequestQueue (V4.4.11 - 5.10.2022) qlen 2, sending 00ce000000060204002e0028 via 172.16.99.193:4196, read buffer empty, id 2, fCode 4, tid 70,
request: id 2, read fc 4 i46, len 40, tid 206, master device Strom.Waermepumpe, reading Current_Avr__A (getUpdate for combined i46 len 2 Current_Avr__A with i48 len 2 Current_Sum__A and i52 len 2 Power_Sum__W and i84 len 2 Power_Sum_demand__W), queued 0.03 secs ago
2022.11.19 17:39:05 5: Strom.Waermepumpe: Send called from ProcessRequestQueue
2022.11.19 17:39:05 5: DevIo_SimpleWrite Strom.Waermepumpe: 00ce000000060204002e0028
2022.11.19 17:39:05 5: Strom.Waermepumpe: StartQueueTimer called from ProcessRequestQueue sets internal timer to process queue in 1.000 seconds
2022.11.19 17:39:05 5: Strom.Waermepumpe: readFn buffer: 00ce000000530204503e151df13edfacea00000000418a9d950000000042c7b77b00000000c2c1b7ed3e4e0d7400000000c29fc95d000000004247f27543125eb800000000423ab127434e19db43920c0745021c3f44638f97
2022.11.19 17:39:05 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn protocol TCP expecting id 2
2022.11.19 17:39:05 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 206, dlen 83 and potential data 503e151df13edfacea00000000418a9d950000000042c7b77b00000000c2c1b7ed3e4e0d7400000000c29fc95d000000004247f27543125eb800000000423ab127434e19db43920c0745021c3f44638f97
2022.11.19 17:39:05 5: Strom.Waermepumpe: HandleResponse called from ReadFn
2022.11.19 17:39:05 5: Strom.Waermepumpe: ParseResponse called from HandleResponse
2022.11.19 17:39:05 5: Strom.Waermepumpe: now parsing response data objects, master is Strom.Waermepumpe relay is undefined
2022.11.19 17:39:05 5: Strom.Waermepumpe: ParseDataString called from HandleResponse with data hex 3e151df13edfacea00000000418a9d950000000042c7b77b00000000c2c1b7ed3e4e0d7400000000c29fc95d000000004247f27543125eb800000000423ab127434e19db43920c0745021c3f44638f97, type i, adr 46, op read
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString called from ParseDataString with data hex 3e151df13edfacea00000000418a9d950000000042c7b77b00000000c2c1b7ed3e4e0d7400000000c29fc95d000000004247f27543125eb800000000423ab127434e19db43920c0745021c3f44638f97, type i, adr 46, valuesLen 40, op read
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i50
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i51
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i54
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i55
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i58
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i59
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i64
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i65
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i68
2022.11.19 17:39:05 5: Strom.Waermepumpe: SplitDataString has no information about handling i69
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects called from ParseDataString with objList i46,i48,i52,i56,i60,i62,i66,i70,i72,i74,i76,i78,i80,i82,i84
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects sortedList i46,i48,i52,i56,i60,i62,i66,i70,i72,i74,i76,i78,i80,i82,i84
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 3e151df1 with f> to 0.145622029900551
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.145622029900551 with format %.1f, result is 0.1
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.1 to Current_Avr__A
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 3edfacea with f> to 0.436866104602814
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.436866104602814 with format %.2f, result is 0.44
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.44 to Current_Sum__A
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 418a9d95 with f> to 17.3269443511963
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 17.3269443511963 with format %.1f, result is 17.3
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 17.3 to Power_Sum__W
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 42c7b77b with f> to 99.8583602905273
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 99.8583602905273 with format %.1f, result is 99.9
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 99.9 to Power_Sum__VA
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked c2c1b7ed with f> to -96.8592300415039
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats -96.8592300415039 with format %.1f, result is -96.9
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value -96.9 to Power_Sum__VAr
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 3e4e0d74 with f> to 0.201223194599152
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0.201223194599152 with format %.1f, result is 0.2
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.2 to PowerFactor
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked c29fc95d with f> to -79.8932876586914
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats -79.8932876586914 with format %.1f, result is -79.9
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value -79.9 to CosPhi__grd
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 4247f275 with f> to 49.9867744445801
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 49.9867744445801 with format %.1f, result is 50.0
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 50.0 to Frequency__Hz
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 43125eb8 with f> to 146.369995117188
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 146.369995117188 with format %.3f, result is 146.370
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 146.370 to Energy_import__kWh
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 00000000 with f> to 0
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 0 with format %.3f, result is 0.000
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 0.000 to Energy_export__kWh
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 423ab127 with f> to 46.6730003356934
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 46.6730003356934 with format %.3f, result is 46.673
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 46.673 to Energy_import__kVArh
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 434e19db with f> to 206.100997924805
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 206.100997924805 with format %.3f, result is 206.101
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 206.101 to Energy_export__kVArh
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 43920c07 with f> to 292.093963623047
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 292.093963623047 with format %.3f, result is 292.094
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 292.094 to Energy_apparent__kVAh
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 45021c3f with f> to 2081.76538085938
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 2081.76538085938 with format %.3f, result is 2081.765
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 2081.765 to Charge__kAh
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:05 5: Strom.Waermepumpe: CreateDataObjects unpacked 44638f97 with f> to 910.243591308594
2022.11.19 17:39:05 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 910.243591308594 with format %.1f, result is 910.2
2022.11.19 17:39:05 4: Strom.Waermepumpe: CreateDataObjects assigns value 910.2 to Power_Sum_demand__W
2022.11.19 17:39:05 5: Strom.Waermepumpe: ParseDataString created 15 readings
2022.11.19 17:39:05 4: Strom.Waermepumpe: HandleResponse done, current frame / read buffer: 00ce000000530204503e151df13edfacea00000000418a9d950000000042c7b77b00000000c2c1b7ed3e4e0d7400000000c29fc95d000000004247f27543125eb800000000423ab127434e19db43920c0745021c3f44638f97, id 2, fCode 4, tid 206,
request: id 2, read fc 4 i46, len 40, tid 206, master device Strom.Waermepumpe, reading Current_Avr__A (getUpdate for combined i46 len 2 Current_Avr__A with i48 len 2 Current_Sum__A and i52 len 2 Power_Sum__W and i84 len 2 Power_Sum_demand__W), queued 0.22 secs ago, sent 0.19 secs ago,
2022.11.19 17:39:05 5: Strom.Waermepumpe: ResetExpect for HandleResponse from response to idle
2022.11.19 17:39:05 5: Strom.Waermepumpe: StartQueueTimer called from HandleResponse sets internal timer to process queue in 0.000 seconds
2022.11.19 17:39:05 5: Strom.Waermepumpe: DropFrame called from ReadFn - drop 00ce000000530204503e151df13edfacea00000000418a9d950000000042c7b77b00000000c2c1b7ed3e4e0d7400000000c29fc95d000000004247f27543125eb800000000423ab127434e19db43920c0745021c3f44638f97
2022.11.19 17:39:05 5: Strom.Waermepumpe: ProcessRequestQueue called from Fhem internal timer as queue:Strom.Waermepumpe, qlen 1, request: request: id 2, read fc 4 i100, len 4, tid 62, master device Strom.Waermepumpe, reading Power_Sum_demand__VA (getUpdate for combined i100 len 2 Power_Sum_demand__VA with i102 len 2 Power_Max_demand__VA), queued 0.22 secs ago
2022.11.19 17:39:05 5: Strom.Waermepumpe: checkDelays busDelayRead, last activity on bus was 0.012 secs ago, required delay is 0
2022.11.19 17:39:05 5: Strom.Waermepumpe: checkDelays clientSwitchDelay is not relevant
2022.11.19 17:39:05 5: Strom.Waermepumpe: checkDelays sendDelay, last send to same device was 0.190 secs ago, required delay is 0.7
2022.11.19 17:39:05 5: Strom.Waermepumpe: checkDelays commDelay, last communication with same device was 0.012 secs ago, required delay is 0.7
2022.11.19 17:39:05 4: Strom.Waermepumpe: checkDelays found commDelay not over, set timer to try again in 0.688
2022.11.19 17:39:06 5: Strom.Waermepumpe: ProcessRequestQueue called from Fhem internal timer as queue:Strom.Waermepumpe, qlen 1, request: request: id 2, read fc 4 i100, len 4, tid 62, master device Strom.Waermepumpe, reading Power_Sum_demand__VA (getUpdate for combined i100 len 2 Power_Sum_demand__VA with i102 len 2 Power_Max_demand__VA), queued 0.91 secs ago
2022.11.19 17:39:06 5: Strom.Waermepumpe: checkDelays commDelay, last communication with same device was 0.706 secs ago, required delay is 0.7
2022.11.19 17:39:06 5: Strom.Waermepumpe: checkDelays clientSwitchDelay is not relevant
2022.11.19 17:39:06 5: Strom.Waermepumpe: checkDelays sendDelay, last send to same device was 0.884 secs ago, required delay is 0.7
2022.11.19 17:39:06 5: Strom.Waermepumpe: checkDelays busDelayRead, last activity on bus was 0.706 secs ago, required delay is 0
2022.11.19 17:39:06 4: Strom.Waermepumpe: ProcessRequestQueue (V4.4.11 - 5.10.2022) qlen 1, sending 003e00000006020400640004 via 172.16.99.193:4196, read buffer empty,
request: id 2, read fc 4 i100, len 4, tid 62, master device Strom.Waermepumpe, reading Power_Sum_demand__VA (getUpdate for combined i100 len 2 Power_Sum_demand__VA with i102 len 2 Power_Max_demand__VA), queued 0.91 secs ago
2022.11.19 17:39:06 5: Strom.Waermepumpe: Send called from ProcessRequestQueue
2022.11.19 17:39:06 5: DevIo_SimpleWrite Strom.Waermepumpe: 003e00000006020400640004
2022.11.19 17:39:06 5: Strom.Waermepumpe: readFn buffer: 003e0000000b020408448bf4b9454fb032
2022.11.19 17:39:06 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn protocol TCP expecting id 2
2022.11.19 17:39:06 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 62, dlen 11 and potential data 08448bf4b9454fb032
2022.11.19 17:39:06 5: Strom.Waermepumpe: HandleResponse called from ReadFn
2022.11.19 17:39:06 5: Strom.Waermepumpe: ParseResponse called from HandleResponse
2022.11.19 17:39:06 5: Strom.Waermepumpe: now parsing response data objects, master is Strom.Waermepumpe relay is undefined
2022.11.19 17:39:06 5: Strom.Waermepumpe: ParseDataString called from HandleResponse with data hex 448bf4b9454fb032, type i, adr 100, op read
2022.11.19 17:39:06 5: Strom.Waermepumpe: SplitDataString called from ParseDataString with data hex 448bf4b9454fb032, type i, adr 100, valuesLen 4, op read
2022.11.19 17:39:06 5: Strom.Waermepumpe: CreateDataObjects called from ParseDataString with objList i100,i102
2022.11.19 17:39:06 5: Strom.Waermepumpe: CreateDataObjects sortedList i100,i102
2022.11.19 17:39:06 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:06 5: Strom.Waermepumpe: CreateDataObjects unpacked 448bf4b9 with f> to 1119.64758300781
2022.11.19 17:39:06 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 1119.64758300781 with format %.1f, result is 1119.6
2022.11.19 17:39:06 4: Strom.Waermepumpe: CreateDataObjects assigns value 1119.6 to Power_Sum_demand__VA
2022.11.19 17:39:06 5: Strom.Waermepumpe: CreateParseInfoCache called
2022.11.19 17:39:06 5: Strom.Waermepumpe: CreateDataObjects unpacked 454fb032 with f> to 3323.01220703125
2022.11.19 17:39:06 5: Strom.Waermepumpe: FormatVal for CreateDataObjects formats 3323.01220703125 with format %.1f, result is 3323.0
2022.11.19 17:39:06 4: Strom.Waermepumpe: CreateDataObjects assigns value 3323.0 to Power_Max_demand__VA
2022.11.19 17:39:06 5: Strom.Waermepumpe: ParseDataString created 2 readings
2022.11.19 17:39:06 4: Strom.Waermepumpe: HandleResponse done, current frame / read buffer: 003e0000000b020408448bf4b9454fb032, id 2, fCode 4, tid 62,
request: id 2, read fc 4 i100, len 4, tid 62, master device Strom.Waermepumpe, reading Power_Sum_demand__VA (getUpdate for combined i100 len 2 Power_Sum_demand__VA with i102 len 2 Power_Max_demand__VA), queued 0.96 secs ago, sent 0.05 secs ago,
2022.11.19 17:39:06 5: Strom.Waermepumpe: ResetExpect for HandleResponse from response to idle
2022.11.19 17:39:06 5: Strom.Waermepumpe: DropFrame called from ReadFn - drop 003e0000000b020408448bf4b9454fb032
2022.11.19 17:39:22 5: Strom.Waermepumpe: readFn buffer: 002c0000000f02040c3e6279ed3dfbdb753daead87
2022.11.19 17:39:22 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn
2022.11.19 17:39:22 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 44, dlen 15 and potential data 0c3e6279ed3dfbdb753daead87
2022.11.19 17:39:22 3: Strom.Waermepumpe: readfn got data while EXPECT was set to idle: 002c0000000f02040c3e6279ed3dfbdb753daead87
2022.11.19 17:39:22 5: Strom.Waermepumpe: DropBuffer for ReadFn clears the reception buffer with 002c0000000f02040c3e6279ed3dfbdb753daead87
2022.11.19 17:39:23 5: Strom.Waermepumpe: readFn buffer: 00170000004702044441885bba0000000042c5873100000000c2bfa51b3e52176d00000000c29fe6d7000000004248091143125eb800000000423ab127434e19db43920c0745021c3f44638f97
2022.11.19 17:39:23 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn
2022.11.19 17:39:23 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 23, dlen 71 and potential data 4441885bba0000000042c5873100000000c2bfa51b3e52176d00000000c29fe6d7000000004248091143125eb800000000423ab127434e19db43920c0745021c3f44638f97
2022.11.19 17:39:23 3: Strom.Waermepumpe: readfn got data while EXPECT was set to idle: 00170000004702044441885bba0000000042c5873100000000c2bfa51b3e52176d00000000c29fe6d7000000004248091143125eb800000000423ab127434e19db43920c0745021c3f44638f97
2022.11.19 17:39:23 5: Strom.Waermepumpe: DropBuffer for ReadFn clears the reception buffer with 00170000004702044441885bba0000000042c5873100000000c2bfa51b3e52176d00000000c29fe6d7000000004248091143125eb800000000423ab127434e19db43920c0745021c3f44638f97
2022.11.19 17:39:23 5: Strom.Waermepumpe: readFn buffer: 004f000000370204343df820fe000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
2022.11.19 17:39:23 5: Strom.Waermepumpe: ParseFrameStart called from ReadFn
2022.11.19 17:39:23 4: Strom.Waermepumpe: ParseFrameStart (TCP, master) extracted id 2, fCode 4, tid 79, dlen 55 and potential data 343df820fe000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
2022.11.19 17:39:23 3: Strom.Waermepumpe: readfn got data while EXPECT was set to idle: 004f000000370204343df820fe000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
2022.11.19 17:39:23 5: Strom.Waermepumpe: DropBuffer for ReadFn clears the reception buffer with 004f000000370204343df820fe000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000


Der Zähler hing vorher an einen USB-RS485-Wandler (angesprochen über ein ModBus-Device) und verursachte keine Fehlermeldungen.

StefanStrobel

Sehr seltsam. Für mich sieht das aus als ob noch ein anderes Device Requests erzeugt.
Im zweiten Log kommen 20 Sekunden nach dem Lesezyklus noch einmal Daten.
Im ersten Log waren es 10 Sekunden vor dem Zyklus.
Hast Du noch ein anderes Gerät (im Netz oder in Fhem), das auch auf den Wandler oder direkt auf den Bus zugreift?
Was passiert denn, wenn Du das Intervall ausschaltest. Kommen dann auch regelmäßig ungefragt Daten?

Gruß
   Stefan

roedert

Zitat von: StefanStrobel am 19 November 2022, 18:39:48
Hast Du noch ein anderes Gerät (im Netz oder in Fhem), das auch auf den Wandler oder direkt auf den Bus zugreift?

Ich Depp!!!  >:(
Ich hatte den Wandler zuerst in meinem em FHEM-Testsystem eingerichtet und dort vergessen zu deaktivieren/löschen.
Nachdem er nun dort weg ist, ist im FHEM-Log alles schön ruhig.

Besten Dank für deine Unterstützung und deine Geduld!

roedert

#14
Naja, vielleicht doch ein wenig zu früh gefreut. Habe nun auch den 2. SDM630 an den TCP-Wandler gehangen und in FHEM die Definition entsprechend angepasst:

defmod Strom.gesamt ModbusSDM630M 1 60 172.16.99.193:4196 TCP
defmod Strom.Waermepumpe ModbusSDM630M 2 60 172.16.99.193:4196 TCP


Nun habe ich wieder die Meldungen "readfn got data.." im Log - scheinbar stören sich die beiden Device-Definitionen gegeneinander.
Wenn ich eines der beiden Devices deaktiviere, ist wieder alles in Ordnung.

Wie kann man dies hier richtig lösen? Irgendwie müsste das 2. Modbus-Device die TCP-Verbindung des erstem Devices mitnutzen statt eine neue aufzubauen?


Edit: Nachdem ich TCP-RTU auf dem TCP-Wandler abgeschaltet habe und die beiden SDM630 in FHEM mit RTU statt TCP definiert habe, läuft eigentlich alles ganz gut.