Neue Versionen und Support zum Modbus-Modul

Tom_S · 28 November 2018, 18:48:01

naja, das greift ja auf das selbe Modul zurück. Ich weis nicht, ob ich dafür ein eigenes Modul brauche. Es funktioniert ja alles soweit. Wenn es mit deinem Modul geht, liegt es doch nur an meiner config oder?

LG

StefanStrobel · 29 November 2018, 17:05:34

Hallo Tom,

eigentlich sollte die alte Konfig mit dem neuen Modul noch genauso funktionieren.
Könntest Du mal verbose auf 5 setzen und dann das Log posten?
Zur Sicherheit solltest Du dabei auch das event-on-change-reading entfernen.

Gruß
Stefan

Tom_S · 29 November 2018, 20:13:56

mach ich doch.

also ohne event-on-change-reading mit verbose 5

Code Auswählen


2018.11.29 19:40:49 5: SE7K: GetUpdate called from ModbusLD_ControlSet
2018.11.29 19:40:49 5: SE7K: GetUpdate objects from attributes: h20 h100 h71 h103 h81 h126 h101 h107 h98 h106 h84 h75 h123 h85 h80 h93 h96 h83 h21 h79
2018.11.29 19:40:49 5: SE7K: GetUpdate full object list: h100 h101 h103 h106 h107 h123 h126 h20 h21 h71 h75 h79 h80 h81 h83 h84 h85 h93 h96 h98
2018.11.29 19:40:49 5: SE7K: GetUpdate check h100 => I_DC_Power_raw, poll = 1, last = 1543515232.99694
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_DC_Power_raw
2018.11.29 19:40:49 5: SE7K: GetUpdate check h101 => I_DC_Power, poll = 1, last = 1543515233.00012
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_DC_Power
2018.11.29 19:40:49 5: SE7K: GetUpdate check h103 => Temperature, poll = 1, last = 1543515233.00342
2018.11.29 19:40:49 4: SE7K: GetUpdate will request Temperature
2018.11.29 19:40:49 5: SE7K: GetUpdate check h106 => I_Temp_SF, poll = 1, last = 1543515233.00627
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_Temp_SF
2018.11.29 19:40:49 5: SE7K: GetUpdate check h107 => C_Status, poll = 1, last = 1543515233.01054
2018.11.29 19:40:49 4: SE7K: GetUpdate will request C_Status
2018.11.29 19:40:49 5: SE7K: GetUpdate check h123 => U_L1, poll = 1, last = 1543515232.81453
2018.11.29 19:40:49 4: SE7K: GetUpdate will request U_L1
2018.11.29 19:40:49 5: SE7K: GetUpdate check h126 => I_L1, poll = 1, last = 1543515232.81798
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_L1
2018.11.29 19:40:49 5: SE7K: GetUpdate check h20 => I_AC_Energie_year, poll = 1, last = 1543515233.13874
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_AC_Energie_year
2018.11.29 19:40:49 5: SE7K: GetUpdate check h21 => I_AC_Energie_month, poll = 1, last = 1543515233.14194
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_AC_Energie_month
2018.11.29 19:40:49 5: SE7K: GetUpdate check h71 => I_AC_Strom, poll = 1, last = 1543515232.96024
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_AC_Strom
2018.11.29 19:40:49 5: SE7K: GetUpdate check h75 => I_AC_Strom_SF, poll = 1, last = 1543515232.96379
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_AC_Strom_SF
2018.11.29 19:40:49 5: SE7K: GetUpdate check h79 => I_L1_Spannung, poll = 1, last = 1543515232.96758
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_L1_Spannung
2018.11.29 19:40:49 5: SE7K: GetUpdate check h80 => I_L2_Spannung, poll = 1, last = 1543515232.97072
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_L2_Spannung
2018.11.29 19:40:49 5: SE7K: GetUpdate check h81 => I_L3_Spannung, poll = 1, last = 1543515232.97378
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_L3_Spannung
2018.11.29 19:40:49 5: SE7K: GetUpdate check h83 => I_AC_Power_raw, poll = 1, last = 1543515232.97698
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_AC_Power_raw
2018.11.29 19:40:49 5: SE7K: GetUpdate check h84 => I_AC_Power, poll = 1, last = 1543515232.98031
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_AC_Power
2018.11.29 19:40:49 5: SE7K: GetUpdate check h85 => I_AC_Frequenz, poll = 1, last = 1543515232.98342
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_AC_Frequenz
2018.11.29 19:40:49 5: SE7K: GetUpdate check h93 => I_AC_Energie, poll = 1, last = 1543515232.98721
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_AC_Energie
2018.11.29 19:40:49 5: SE7K: GetUpdate check h96 => I_DC_Strom, poll = 1, last = 1543515232.9905
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_DC_Strom
2018.11.29 19:40:49 5: SE7K: GetUpdate check h98 => I_DC_Spannung, poll = 1, last = 1543515232.99375
2018.11.29 19:40:49 4: SE7K: GetUpdate will request I_DC_Spannung
2018.11.29 19:40:49 5: SE7K: GetUpdate tries to combine read commands
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Energie_year (h20) with I_AC_Energie_month (h21), span=2, max=50, drop read for h21
2018.11.29 19:40:49 5: SE7K: GetUpdate cant combine request for I_AC_Energie_year / h20 with I_AC_Strom / h71, span 52 > max 50
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Strom_SF (h75), span=5, max=50, drop read for h75
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_L1_Spannung (h79), span=9, max=50, drop read for h79
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_L2_Spannung (h80), span=10, max=50, drop read for h80
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_L3_Spannung (h81), span=11, max=50, drop read for h81
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Power_raw (h83), span=13, max=50, drop read for h83
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Power (h84), span=14, max=50, drop read for h84
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Frequenz (h85), span=15, max=50, drop read for h85
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Energie (h93), span=24, max=50, drop read for h93
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_DC_Strom (h96), span=26, max=50, drop read for h96
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_DC_Spannung (h98), span=28, max=50, drop read for h98
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_DC_Power_raw (h100), span=30, max=50, drop read for h100
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_DC_Power (h101), span=31, max=50, drop read for h101
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with Temperature (h103), span=33, max=50, drop read for h103
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_Temp_SF (h106), span=36, max=50, drop read for h106
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with C_Status (h107), span=37, max=50, drop read for h107
2018.11.29 19:40:49 5: SE7K: GetUpdate cant combine request for I_AC_Strom / h71 with U_L1 / h123, span 53 > max 50
2018.11.29 19:40:49 5: SE7K: GetUpdate combines request for U_L1 (h123) with I_L1 (h126), span=4, max=50, drop read for h126
2018.11.29 19:40:49 5: SE7K: GetUpdate doesn't sort objList before sending requests
2018.11.29 19:40:49 5: SE7K: DoRequest called from ModbusLD_GetUpdate
2018.11.29 19:40:49 4: SE7K: DoRequest (called from ModbusLD_GetUpdate) created, request: id 1, fCode 3, tid 134, type h, adr 123, len 4 for device SE7K reading U_L1, read buffer empty
2018.11.29 19:40:49 5: SE7K: QueueRequest called from ModbusLD_DoRequest with h123, qlen 0
2018.11.29 19:40:49 5: SE7K: ProcessRequestQueue called from QueueRequest as direct:SE7K
2018.11.29 19:40:49 5: SE7K: open called from ProcessRequestQueue
2018.11.29 19:40:49 4: SE7K: open trying to open connection to 192.168.115.15:502
2018.11.29 19:40:49 3: Opening SE7K device 192.168.115.15:502
2018.11.29 19:40:49 5: HttpUtils url=http://192.168.115.15:502/
2018.11.29 19:40:50 5: SE7K: ProcessRequestQueue called from QueueRequest returns, device is disconnected, qlen 1, try again in 1 seconds
2018.11.29 19:40:50 5: SE7K: StartQueueTimer called form ProcessRequestQueue sets internal timer to call Modbus_ProcessRequestQueue in 1.000 seconds
2018.11.29 19:40:50 5: SE7K: DoRequest called from ModbusLD_GetUpdate
2018.11.29 19:40:50 4: SE7K: DoRequest (called from ModbusLD_GetUpdate) created, request: id 1, fCode 3, tid 72, type h, adr 20, len 2 for device SE7K reading I_AC_Energie_year, read buffer empty
2018.11.29 19:40:50 5: SE7K: QueueRequest called from ModbusLD_DoRequest with h20, qlen 1
2018.11.29 19:40:50 5: SE7K: ProcessRequestQueue called from QueueRequest as direct:SE7K
2018.11.29 19:40:50 5: SE7K: open called from ProcessRequestQueue
2018.11.29 19:40:50 5: SE7K: ProcessRequestQueue called from QueueRequest returns, device is disconnected, qlen 2, try again in 1 seconds
2018.11.29 19:40:50 5: SE7K: StartQueueTimer called form ProcessRequestQueue sets internal timer to call Modbus_ProcessRequestQueue in 1.000 seconds
2018.11.29 19:40:50 5: SE7K: DoRequest called from ModbusLD_GetUpdate
2018.11.29 19:40:50 4: SE7K: DoRequest (called from ModbusLD_GetUpdate) created, request: id 1, fCode 3, tid 251, type h, adr 71, len 37 for device SE7K reading I_AC_Strom, read buffer empty
2018.11.29 19:40:50 5: SE7K: QueueRequest called from ModbusLD_DoRequest with h71, qlen 2
2018.11.29 19:40:50 5: SE7K: ProcessRequestQueue called from QueueRequest as direct:SE7K
2018.11.29 19:40:50 5: SE7K: open called from ProcessRequestQueue
2018.11.29 19:40:50 5: SE7K: ProcessRequestQueue called from QueueRequest returns, device is disconnected, qlen 3, try again in 1 seconds
2018.11.29 19:40:50 5: SE7K: StartQueueTimer called form ProcessRequestQueue sets internal timer to call Modbus_ProcessRequestQueue in 1.000 seconds
2018.11.29 19:40:50 4: SE7K device opened
2018.11.29 19:40:50 4: SE7K: SetUpdateTimer updated timer - will call GetUpdate in 300.0 seconds at 2018-11-29 19:45:50 - Interval 300
2018.11.29 19:40:51 5: SE7K: ProcessRequestQueue called from HandleTimeout as queue:SE7K
2018.11.29 19:40:51 5: SE7K: CheckDelay called from ProcessRequestQueue commDelay (0.1s since 19:13:53.134) for SE7K, delay over
2018.11.29 19:40:51 5: SE7K: CheckDelay called from ProcessRequestQueue sendDelay (0.1s since 19:13:53.130) for SE7K, delay over
2018.11.29 19:40:51 5: SE7K: PackRequest called from ProcessRequestQueue
2018.11.29 19:40:51 4: SE7K: ProcessRequestQueue got pdu from PackRequest: 03007b0004
2018.11.29 19:40:51 5: SE7K: PackFrame called from ProcessRequestQueue id 1, tid 134, pdu 03007b0004
2018.11.29 19:40:51 4: SE7K: ProcessRequestQueue (V4.0.17 - 10.11.2018) sending, request: id 1, fCode 3, tid 134, type h, adr 123, len 4 for device SE7K reading U_L1, read buffer empty
2018.11.29 19:40:51 5: SW: 0086000000060103007b0004
2018.11.29 19:40:51 5: SE7K: StartQueueTimer called form ProcessRequestQueue sets internal timer to call Modbus_ProcessRequestQueue in 1.000 seconds
2018.11.29 19:40:51 4: 192.168.115.15:502 disconnected, waiting to reappear (SE7K)
2018.11.29 19:40:51 5: SE7K: StopQueueTimer called from Open removes internal timer to call Modbus_ProcessRequestQueue
2018.11.29 19:40:51 5: HttpUtils url=http://192.168.115.15:502/
2018.11.29 19:40:51 4: 192.168.115.15:502 reappeared (SE7K)
2018.11.29 19:40:51 4: SE7K: SetUpdateTimer updated timer - will call GetUpdate in 300.0 seconds at 2018-11-29 19:45:51 - Interval 300
2018.11.29 19:40:53 3: SE7K: ResponseTimeout called, devhash=HASH(0x20e3388), name of devhash=SE7K
2018.11.29 19:40:53 3: SE7K: Timeout waiting for a modbus response, request: id 1, fCode 3, tid 134, type h, adr 123, len 4 for device SE7K reading U_L1, read buffer empty
2018.11.29 19:40:53 5: SE7K: DropFrame - drop 
2018.11.29 19:40:53 5: SE7K: StartQueueTimer called form ResponseTimeout sets internal timer to call Modbus_ProcessRequestQueue in 0.000 seconds
2018.11.29 19:40:53 5: SE7K: ProcessRequestQueue called from HandleTimeout as queue:SE7K
2018.11.29 19:40:53 5: SE7K: CheckDelay called from ProcessRequestQueue commDelay (0.1s since 19:13:53.134) for SE7K, delay over
2018.11.29 19:40:53 5: SE7K: CheckDelay called from ProcessRequestQueue sendDelay (0.1s since 19:40:51.025) for SE7K, delay over
2018.11.29 19:40:53 5: SE7K: PackRequest called from ProcessRequestQueue
2018.11.29 19:40:53 4: SE7K: ProcessRequestQueue got pdu from PackRequest: 0300140002
2018.11.29 19:40:53 5: SE7K: PackFrame called from ProcessRequestQueue id 1, tid 72, pdu 0300140002
2018.11.29 19:40:53 4: SE7K: ProcessRequestQueue (V4.0.17 - 10.11.2018) sending, request: id 1, fCode 3, tid 72, type h, adr 20, len 2 for device SE7K reading I_AC_Energie_year, read buffer empty
2018.11.29 19:40:53 5: SW: 004800000006010300140002
2018.11.29 19:40:53 5: SE7K: StartQueueTimer called form ProcessRequestQueue sets internal timer to call Modbus_ProcessRequestQueue in 1.000 seconds
2018.11.29 19:40:53 5: SE7K: read buffer: 0048000000070103045345374b
2018.11.29 19:40:53 5: SE7K: ParseFrameStart (TCP) extracted id 1, fCode 3, tid 72, dlen 7 and data 045345374b
2018.11.29 19:40:53 5: SE7K: HandleResponse called from Read
2018.11.29 19:40:53 5: SE7K: ParseResponse called from HandleResponse
2018.11.29 19:40:53 5: SE7K: HandleResponse now passing to logical device SE7K for parsing data
2018.11.29 19:40:53 5: SE7K: ParseObj called with data 5345374b, type h, adr 20, valuesLen 2, op read
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h20: reading=I_AC_Energie_year, unpack=n, expr=$val / 100, format=%.2f kWh, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 5345374b with n to 21317 hex 3231333137
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Energie_year, val=21317, expr=$val / 100
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 213.17
2018.11.29 19:40:53 5: SE7K: ParseObj for I_AC_Energie_year does sprintf with format %.2f kWh, value is 213.17
2018.11.29 19:40:53 5: SE7K: ParseObj for I_AC_Energie_year sprintf result is 213.17 kWh
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 213.17 kWh to I_AC_Energie_year
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h21
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h21: reading=I_AC_Energie_month, unpack=n, expr=$val / 100, format=%.2f kWh, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 374b with n to 14155 hex 3134313535
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Energie_month, val=14155, expr=$val / 100
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 141.55
2018.11.29 19:40:53 5: SE7K: ParseObj for I_AC_Energie_month does sprintf with format %.2f kWh, value is 141.55
2018.11.29 19:40:53 5: SE7K: ParseObj for I_AC_Energie_month sprintf result is 141.55 kWh
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 141.55 kWh to I_AC_Energie_month
2018.11.29 19:40:53 5: SE7K: HandleResponse got 2 readings from ParseObj for SE7K
2018.11.29 19:40:53 4: SE7K: ResponseDone, request: id 1, fCode 3, tid 72, type h, adr 20, len 2 for device SE7K reading I_AC_Energie_year, Current read buffer: 0048000000070103045345374b, Id 1, fCode 3, tid 72, response: id 1, fCode 3, type h, adr 20, len 2, value 5345374b
2018.11.29 19:40:53 5: SE7K: DropFrame - drop 0048000000070103045345374b
2018.11.29 19:40:53 5: SE7K: StartQueueTimer called form Read sets internal timer to call Modbus_ProcessRequestQueue in 0.000 seconds
2018.11.29 19:40:53 5: SE7K: ProcessRequestQueue called from HandleTimeout as queue:SE7K
2018.11.29 19:40:53 4: SE7K: CheckDelay called from ProcessRequestQueue commDelay (0.1s since 19:40:53.471) for SE7K, rest 0.037, set timer to try again later
2018.11.29 19:40:53 5: SE7K: StartQueueTimer called form CheckDelay sets internal timer to call Modbus_ProcessRequestQueue in 0.037 seconds
2018.11.29 19:40:53 5: SE7K: ProcessRequestQueue called from HandleTimeout as queue:SE7K
2018.11.29 19:40:53 5: SE7K: CheckDelay called from ProcessRequestQueue commDelay (0.1s since 19:40:53.471) for SE7K, delay over
2018.11.29 19:40:53 5: SE7K: CheckDelay called from ProcessRequestQueue sendDelay (0.1s since 19:40:53.030) for SE7K, delay over
2018.11.29 19:40:53 5: SE7K: PackRequest called from ProcessRequestQueue
2018.11.29 19:40:53 4: SE7K: ProcessRequestQueue got pdu from PackRequest: 0300470025
2018.11.29 19:40:53 5: SE7K: PackFrame called from ProcessRequestQueue id 1, tid 251, pdu 0300470025
2018.11.29 19:40:53 4: SE7K: ProcessRequestQueue (V4.0.17 - 10.11.2018) sending, request: id 1, fCode 3, tid 251, type h, adr 71, len 37 for device SE7K reading I_AC_Strom, read buffer empty
2018.11.29 19:40:53 5: SW: 00fb00000006010300470025
2018.11.29 19:40:53 5: SE7K: StartQueueTimer called from ProcessRequestQueue removes internal timer because it is not needed now
2018.11.29 19:40:53 5: SE7K: read buffer: 00fb0000004d01034a0000000000000000fffe000000000000092b09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002
2018.11.29 19:40:53 5: SE7K: ParseFrameStart (TCP) extracted id 1, fCode 3, tid 251, dlen 77 and data 4a0000000000000000fffe000000000000092b09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002
2018.11.29 19:40:53 5: SE7K: HandleResponse called from Read
2018.11.29 19:40:53 5: SE7K: ParseResponse called from HandleResponse
2018.11.29 19:40:53 5: SE7K: HandleResponse now passing to logical device SE7K for parsing data
2018.11.29 19:40:53 5: SE7K: ParseObj called with data 0000000000000000fffe000000000000092b09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002, type h, adr 71, valuesLen 37, op read
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h71: reading=I_AC_Strom, unpack=n, expr=$val /ReadingsVal($name,"I_AC_Strom_SF",10)/10, format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 0000000000000000fffe000000000000092b09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Strom, val=0, expr=$val /ReadingsVal($name,"I_AC_Strom_SF",10)/10
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 0 to I_AC_Strom
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h72
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h72
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h73
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h73
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h74
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h74
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h75
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h75: reading=I_AC_Strom_SF, unpack=n, expr=10 ** (65536 - $val), format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked fffe000000000000092b09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 65534 hex 3635353334
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Strom_SF, val=65534, expr=10 ** (65536 - $val)
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 100
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 100 to I_AC_Strom_SF
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h76
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h76
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h77
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h77
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h78
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h78
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h79
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h79: reading=I_L1_Spannung, unpack=n, expr=$val /10, format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 092b09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 2347 hex 32333437
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_L1_Spannung, val=2347, expr=$val /10
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 234.7
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 234.7 to I_L1_Spannung
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h80
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h80: reading=I_L2_Spannung, unpack=n, expr=$val /10, format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 2353 hex 32333533
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_L2_Spannung, val=2353, expr=$val /10
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 235.3
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 235.3 to I_L2_Spannung
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h81
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h81: reading=I_L3_Spannung, unpack=n, expr=$val /10, format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 0931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 2353 hex 32333533
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_L3_Spannung, val=2353, expr=$val /10
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 235.3
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 235.3 to I_L3_Spannung
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h82
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h82
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h83
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h83: reading=I_AC_Power_raw, unpack=n, expr=$val, format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Power_raw, val=0, expr=$val
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 0 to I_AC_Power_raw
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h84
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h84: reading=I_AC_Power, unpack=n, expr=ReadingsVal($name,"I_AC_Power_raw",1) / (($val > 0) ? 10 ** (65536 - $val) : 1), format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 00001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Power, val=0, expr=ReadingsVal($name,"I_AC_Power_raw",1) / (($val > 0) ? 10 ** (65536 - $val) : 1)
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 0 to I_AC_Power
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h85
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h85: reading=I_AC_Frequenz, unpack=n, expr=$val /100, format=%.2f Hz, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 1387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 4999 hex 34393939
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Frequenz, val=4999, expr=$val /100
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 49.99
2018.11.29 19:40:53 5: SE7K: ParseObj for I_AC_Frequenz does sprintf with format %.2f Hz, value is 49.99
2018.11.29 19:40:53 5: SE7K: ParseObj for I_AC_Frequenz sprintf result is 49.99 Hz
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 49.99 Hz to I_AC_Frequenz
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h86
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h86
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h87
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h87
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h88
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h88
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h89
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h89
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h90
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h90
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h91
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h91
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h92
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h92
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h93
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h93: reading=I_AC_Energie, unpack=l>, expr=$val / 1000, format=%.2f kWh, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with l> to 8360407 hex 38333630343037
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Energie, val=8360407, expr=$val / 1000
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 8360.407
2018.11.29 19:40:53 5: SE7K: ParseObj for I_AC_Energie does sprintf with format %.2f kWh, value is 8360.407
2018.11.29 19:40:53 5: SE7K: ParseObj for I_AC_Energie sprintf result is 8360.41 kWh
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 8360.41 kWh to I_AC_Energie
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 2 to h95
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h95
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h96
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h96: reading=I_DC_Strom, unpack=n, expr=$val /ReadingsVal($name,"I_AC_Power_SF",10)/1000, format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked ffff80000000ffff000000008000000080008000fffe0002 with n to 65535 hex 3635353335
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_DC_Strom, val=65535, expr=$val /ReadingsVal($name,"I_AC_Power_SF",10)/1000
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 6.5535
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 6.5535 to I_DC_Strom
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h97
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h97
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h98
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h98: reading=I_DC_Spannung, unpack=n, expr=$val /10, format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 0000ffff000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_DC_Spannung, val=0, expr=$val /10
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 0 to I_DC_Spannung
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h99
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h99
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h100
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h100: reading=I_DC_Power_raw, unpack=n, expr=$val, format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_DC_Power_raw, val=0, expr=$val
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 0 to I_DC_Power_raw
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h101
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h101: reading=I_DC_Power, unpack=n, expr=ReadingsVal($name,"I_DC_Power_raw",1) / (($val > 0) ? 10 ** (65536 - $val) : 1), format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 00008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_DC_Power, val=0, expr=ReadingsVal($name,"I_DC_Power_raw",1) / (($val > 0) ? 10 ** (65536 - $val) : 1)
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 0 to I_DC_Power
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h102
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h102
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h103
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h103: reading=Temperature, unpack=s>, expr=$val * (10 ** ReadingsNum ($name ,"I_Temp_SF",0)), format=%.2f ′C, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 000080008000fffe0002 with s> to 0 hex 30
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for Temperature, val=0, expr=$val * (10 ** ReadingsNum ($name ,"I_Temp_SF",0))
2018.11.29 19:40:53 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:53 5: SE7K: ParseObj for Temperature does sprintf with format %.2f ′C, value is 0
2018.11.29 19:40:53 5: SE7K: ParseObj for Temperature sprintf result is 0.00 ′C
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value 0.00 ′C to Temperature
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h104
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h104
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h105
2018.11.29 19:40:53 5: SE7K: ParseObj has no information about parsing h105
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h106
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h106: reading=I_Temp_SF, unpack=s>, expr=, format=, map=
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked fffe0002 with s> to -2 hex 2d32
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value -2 to I_Temp_SF
2018.11.29 19:40:53 5: SE7K: ParseObj moves to next object, skip 1 to h107
2018.11.29 19:40:53 5: SE7K: ParseObj ObjInfo for h107: reading=C_Status, unpack=n, expr=, format=, map=1:Aus, 2:Nachtmodus, 4:Betrieb
2018.11.29 19:40:53 5: SE7K: ParseObj unpacked 0002 with n to 2 hex 32
2018.11.29 19:40:53 5: SE7K: MapConvert called from ModbusLD_ParseObj converted 2 to Nachtmodus with map 1:Aus, 2:Nachtmodus, 4:Betrieb
2018.11.29 19:40:53 5: SE7K: ParseObj for C_Status maps value 2 to Nachtmodus with 1:Aus, 2:Nachtmodus, 4:Betrieb
2018.11.29 19:40:53 4: SE7K: ParseObj assigns value Nachtmodus to C_Status
2018.11.29 19:40:53 5: SE7K: HandleResponse got 16 readings from ParseObj for SE7K
2018.11.29 19:40:53 4: SE7K: ResponseDone, request: id 1, fCode 3, tid 251, type h, adr 71, len 37 for device SE7K reading I_AC_Strom, Current read buffer: 00fb0000004d01034a0000000000000000fffe000000000000092b09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002, Id 1, fCode 3, tid 251, response: id 1, fCode 3, type h, adr 71, len 37, value 0000000000000000fffe000000000000092b09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002
2018.11.29 19:40:53 5: SE7K: DropFrame - drop 00fb0000004d01034a0000000000000000fffe000000000000092b09310931ffff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002
2018.11.29 19:40:53 5: SE7K: StartQueueTimer called from Read removes internal timer because it is not needed now
2018.11.29 19:40:56 5: SE7K: GetUpdate called from ModbusLD_ControlSet
2018.11.29 19:40:56 5: SE7K: GetUpdate objects from attributes: h20 h100 h71 h103 h81 h126 h101 h107 h98 h106 h84 h75 h123 h85 h80 h93 h96 h83 h21 h79
2018.11.29 19:40:56 5: SE7K: GetUpdate full object list: h100 h101 h103 h106 h107 h123 h126 h20 h21 h71 h75 h79 h80 h81 h83 h84 h85 h93 h96 h98
2018.11.29 19:40:56 5: SE7K: GetUpdate check h100 => I_DC_Power_raw, poll = 1, last = 1543516853.66438
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_DC_Power_raw
2018.11.29 19:40:56 5: SE7K: GetUpdate check h101 => I_DC_Power, poll = 1, last = 1543516853.66945
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_DC_Power
2018.11.29 19:40:56 5: SE7K: GetUpdate check h103 => Temperature, poll = 1, last = 1543516853.67577
2018.11.29 19:40:56 4: SE7K: GetUpdate will request Temperature
2018.11.29 19:40:56 5: SE7K: GetUpdate check h106 => I_Temp_SF, poll = 1, last = 1543516853.68083
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_Temp_SF
2018.11.29 19:40:56 5: SE7K: GetUpdate check h107 => C_Status, poll = 1, last = 1543516853.68693
2018.11.29 19:40:56 4: SE7K: GetUpdate will request C_Status
2018.11.29 19:40:56 5: SE7K: GetUpdate check h123 => U_L1, poll = 1, last = 1543515232.81453
2018.11.29 19:40:56 4: SE7K: GetUpdate will request U_L1
2018.11.29 19:40:56 5: SE7K: GetUpdate check h126 => I_L1, poll = 1, last = 1543515232.81798
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_L1
2018.11.29 19:40:56 5: SE7K: GetUpdate check h20 => I_AC_Energie_year, poll = 1, last = 1543516853.47967
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_AC_Energie_year
2018.11.29 19:40:56 5: SE7K: GetUpdate check h21 => I_AC_Energie_month, poll = 1, last = 1543516853.48616
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_AC_Energie_month
2018.11.29 19:40:56 5: SE7K: GetUpdate check h71 => I_AC_Strom, poll = 1, last = 1543516853.59642
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_AC_Strom
2018.11.29 19:40:56 5: SE7K: GetUpdate check h75 => I_AC_Strom_SF, poll = 1, last = 1543516853.60363
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_AC_Strom_SF
2018.11.29 19:40:56 5: SE7K: GetUpdate check h79 => I_L1_Spannung, poll = 1, last = 1543516853.61099
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_L1_Spannung
2018.11.29 19:40:56 5: SE7K: GetUpdate check h80 => I_L2_Spannung, poll = 1, last = 1543516853.61612
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_L2_Spannung
2018.11.29 19:40:56 5: SE7K: GetUpdate check h81 => I_L3_Spannung, poll = 1, last = 1543516853.62096
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_L3_Spannung
2018.11.29 19:40:56 5: SE7K: GetUpdate check h83 => I_AC_Power_raw, poll = 1, last = 1543516853.6266
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_AC_Power_raw
2018.11.29 19:40:56 5: SE7K: GetUpdate check h84 => I_AC_Power, poll = 1, last = 1543516853.63171
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_AC_Power
2018.11.29 19:40:56 5: SE7K: GetUpdate check h85 => I_AC_Frequenz, poll = 1, last = 1543516853.6375
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_AC_Frequenz
2018.11.29 19:40:56 5: SE7K: GetUpdate check h93 => I_AC_Energie, poll = 1, last = 1543516853.6475
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_AC_Energie
2018.11.29 19:40:56 5: SE7K: GetUpdate check h96 => I_DC_Strom, poll = 1, last = 1543516853.65335
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_DC_Strom
2018.11.29 19:40:56 5: SE7K: GetUpdate check h98 => I_DC_Spannung, poll = 1, last = 1543516853.65891
2018.11.29 19:40:56 4: SE7K: GetUpdate will request I_DC_Spannung
2018.11.29 19:40:56 5: SE7K: GetUpdate tries to combine read commands
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Energie_year (h20) with I_AC_Energie_month (h21), span=2, max=50, drop read for h21
2018.11.29 19:40:56 5: SE7K: GetUpdate cant combine request for I_AC_Energie_year / h20 with I_AC_Strom / h71, span 52 > max 50
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Strom_SF (h75), span=5, max=50, drop read for h75
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_L1_Spannung (h79), span=9, max=50, drop read for h79
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_L2_Spannung (h80), span=10, max=50, drop read for h80
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_L3_Spannung (h81), span=11, max=50, drop read for h81
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Power_raw (h83), span=13, max=50, drop read for h83
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Power (h84), span=14, max=50, drop read for h84
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Frequenz (h85), span=15, max=50, drop read for h85
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_AC_Energie (h93), span=24, max=50, drop read for h93
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_DC_Strom (h96), span=26, max=50, drop read for h96
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_DC_Spannung (h98), span=28, max=50, drop read for h98
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_DC_Power_raw (h100), span=30, max=50, drop read for h100
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_DC_Power (h101), span=31, max=50, drop read for h101
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with Temperature (h103), span=33, max=50, drop read for h103
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with I_Temp_SF (h106), span=36, max=50, drop read for h106
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for I_AC_Strom (h71) with C_Status (h107), span=37, max=50, drop read for h107
2018.11.29 19:40:56 5: SE7K: GetUpdate cant combine request for I_AC_Strom / h71 with U_L1 / h123, span 53 > max 50
2018.11.29 19:40:56 5: SE7K: GetUpdate combines request for U_L1 (h123) with I_L1 (h126), span=4, max=50, drop read for h126
2018.11.29 19:40:56 5: SE7K: GetUpdate doesn't sort objList before sending requests
2018.11.29 19:40:56 5: SE7K: DoRequest called from ModbusLD_GetUpdate
2018.11.29 19:40:56 4: SE7K: DoRequest (called from ModbusLD_GetUpdate) created, request: id 1, fCode 3, tid 1, type h, adr 71, len 37 for device SE7K reading I_AC_Strom, read buffer empty
2018.11.29 19:40:56 5: SE7K: QueueRequest called from ModbusLD_DoRequest with h71, qlen 0
2018.11.29 19:40:56 5: SE7K: ProcessRequestQueue called from QueueRequest as direct:SE7K
2018.11.29 19:40:56 5: SE7K: CheckDelay called from ProcessRequestQueue commDelay (0.1s since 19:40:53.589) for SE7K, delay over
2018.11.29 19:40:56 5: SE7K: CheckDelay called from ProcessRequestQueue sendDelay (0.1s since 19:40:53.579) for SE7K, delay over
2018.11.29 19:40:56 5: SE7K: PackRequest called from ProcessRequestQueue
2018.11.29 19:40:56 4: SE7K: ProcessRequestQueue got pdu from PackRequest: 0300470025
2018.11.29 19:40:56 5: SE7K: PackFrame called from ProcessRequestQueue id 1, tid 1, pdu 0300470025
2018.11.29 19:40:56 4: SE7K: ProcessRequestQueue (V4.0.17 - 10.11.2018) sending, request: id 1, fCode 3, tid 1, type h, adr 71, len 37 for device SE7K reading I_AC_Strom, read buffer empty
2018.11.29 19:40:56 5: SW: 000100000006010300470025
2018.11.29 19:40:56 5: SE7K: StartQueueTimer called from ProcessRequestQueue removes internal timer because it is not needed now
2018.11.29 19:40:56 5: SE7K: DoRequest called from ModbusLD_GetUpdate
2018.11.29 19:40:56 4: SE7K: DoRequest (called from ModbusLD_GetUpdate) created, request: id 1, fCode 3, tid 226, type h, adr 20, len 2 for device SE7K reading I_AC_Energie_year, read buffer empty
2018.11.29 19:40:56 5: SE7K: QueueRequest called from ModbusLD_DoRequest with h20, qlen 0
2018.11.29 19:40:56 5: SE7K: StartQueueTimer called form QueueRequest sets internal timer to call Modbus_ProcessRequestQueue in 1.000 seconds
2018.11.29 19:40:56 5: SE7K: DoRequest called from ModbusLD_GetUpdate
2018.11.29 19:40:56 4: SE7K: DoRequest (called from ModbusLD_GetUpdate) created, request: id 1, fCode 3, tid 19, type h, adr 123, len 4 for device SE7K reading U_L1, read buffer empty
2018.11.29 19:40:56 5: SE7K: QueueRequest called from ModbusLD_DoRequest with h123, qlen 1
2018.11.29 19:40:56 5: SE7K: StartQueueTimer called form QueueRequest has already set internal timer to call Modbus_ProcessRequestQueue in 0.996 seconds
2018.11.29 19:40:56 5: SE7K: read buffer: 00010000004d01034a0000000000000000fffe000000000000092b0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002
2018.11.29 19:40:56 5: SE7K: ParseFrameStart (TCP) extracted id 1, fCode 3, tid 1, dlen 77 and data 4a0000000000000000fffe000000000000092b0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002
2018.11.29 19:40:56 5: SE7K: HandleResponse called from Read
2018.11.29 19:40:56 5: SE7K: ParseResponse called from HandleResponse
2018.11.29 19:40:56 5: SE7K: HandleResponse now passing to logical device SE7K for parsing data
2018.11.29 19:40:56 5: SE7K: ParseObj called with data 0000000000000000fffe000000000000092b0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002, type h, adr 71, valuesLen 37, op read
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h71: reading=I_AC_Strom, unpack=n, expr=$val /ReadingsVal($name,"I_AC_Strom_SF",10)/10, format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 0000000000000000fffe000000000000092b0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Strom, val=0, expr=$val /ReadingsVal($name,"I_AC_Strom_SF",10)/10
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 0 to I_AC_Strom
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h72
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h72
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h73
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h73
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h74
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h74
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h75
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h75: reading=I_AC_Strom_SF, unpack=n, expr=10 ** (65536 - $val), format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked fffe000000000000092b0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 65534 hex 3635353334
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Strom_SF, val=65534, expr=10 ** (65536 - $val)
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 100
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 100 to I_AC_Strom_SF
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h76
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h76
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h77
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h77
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h78
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h78
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h79
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h79: reading=I_L1_Spannung, unpack=n, expr=$val /10, format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 092b0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 2347 hex 32333437
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_L1_Spannung, val=2347, expr=$val /10
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 234.7
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 234.7 to I_L1_Spannung
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h80
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h80: reading=I_L2_Spannung, unpack=n, expr=$val /10, format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 2354 hex 32333534
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_L2_Spannung, val=2354, expr=$val /10
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 235.4
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 235.4 to I_L2_Spannung
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h81
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h81: reading=I_L3_Spannung, unpack=n, expr=$val /10, format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 2350 hex 32333530
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_L3_Spannung, val=2350, expr=$val /10
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 235
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 235 to I_L3_Spannung
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h82
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h82
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h83
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h83: reading=I_AC_Power_raw, unpack=n, expr=$val, format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Power_raw, val=0, expr=$val
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 0 to I_AC_Power_raw
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h84
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h84: reading=I_AC_Power, unpack=n, expr=ReadingsVal($name,"I_AC_Power_raw",1) / (($val > 0) ? 10 ** (65536 - $val) : 1), format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 00001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Power, val=0, expr=ReadingsVal($name,"I_AC_Power_raw",1) / (($val > 0) ? 10 ** (65536 - $val) : 1)
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 0 to I_AC_Power
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h85
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h85: reading=I_AC_Frequenz, unpack=n, expr=$val /100, format=%.2f Hz, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 1387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with n to 4999 hex 34393939
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Frequenz, val=4999, expr=$val /100
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 49.99
2018.11.29 19:40:56 5: SE7K: ParseObj for I_AC_Frequenz does sprintf with format %.2f Hz, value is 49.99
2018.11.29 19:40:56 5: SE7K: ParseObj for I_AC_Frequenz sprintf result is 49.99 Hz
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 49.99 Hz to I_AC_Frequenz
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h86
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h86
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h87
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h87
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h88
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h88
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h89
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h89
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h90
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h90
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h91
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h91
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h92
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h92
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h93
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h93: reading=I_AC_Energie, unpack=l>, expr=$val / 1000, format=%.2f kWh, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 007f91d70000ffff80000000ffff000000008000000080008000fffe0002 with l> to 8360407 hex 38333630343037
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Energie, val=8360407, expr=$val / 1000
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 8360.407
2018.11.29 19:40:56 5: SE7K: ParseObj for I_AC_Energie does sprintf with format %.2f kWh, value is 8360.407
2018.11.29 19:40:56 5: SE7K: ParseObj for I_AC_Energie sprintf result is 8360.41 kWh
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 8360.41 kWh to I_AC_Energie
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 2 to h95
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h95
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h96
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h96: reading=I_DC_Strom, unpack=n, expr=$val /ReadingsVal($name,"I_AC_Power_SF",10)/1000, format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked ffff80000000ffff000000008000000080008000fffe0002 with n to 65535 hex 3635353335
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_DC_Strom, val=65535, expr=$val /ReadingsVal($name,"I_AC_Power_SF",10)/1000
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 6.5535
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 6.5535 to I_DC_Strom
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h97
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h97
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h98
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h98: reading=I_DC_Spannung, unpack=n, expr=$val /10, format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 0000ffff000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_DC_Spannung, val=0, expr=$val /10
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 0 to I_DC_Spannung
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h99
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h99
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h100
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h100: reading=I_DC_Power_raw, unpack=n, expr=$val, format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 000000008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_DC_Power_raw, val=0, expr=$val
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 0 to I_DC_Power_raw
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h101
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h101: reading=I_DC_Power, unpack=n, expr=ReadingsVal($name,"I_DC_Power_raw",1) / (($val > 0) ? 10 ** (65536 - $val) : 1), format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 00008000000080008000fffe0002 with n to 0 hex 30
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_DC_Power, val=0, expr=ReadingsVal($name,"I_DC_Power_raw",1) / (($val > 0) ? 10 ** (65536 - $val) : 1)
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 0 to I_DC_Power
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h102
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h102
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h103
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h103: reading=Temperature, unpack=s>, expr=$val * (10 ** ReadingsNum ($name ,"I_Temp_SF",0)), format=%.2f ′C, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 000080008000fffe0002 with s> to 0 hex 30
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for Temperature, val=0, expr=$val * (10 ** ReadingsNum ($name ,"I_Temp_SF",0))
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 0
2018.11.29 19:40:56 5: SE7K: ParseObj for Temperature does sprintf with format %.2f ′C, value is 0
2018.11.29 19:40:56 5: SE7K: ParseObj for Temperature sprintf result is 0.00 ′C
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 0.00 ′C to Temperature
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h104
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h104
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h105
2018.11.29 19:40:56 5: SE7K: ParseObj has no information about parsing h105
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h106
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h106: reading=I_Temp_SF, unpack=s>, expr=, format=, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked fffe0002 with s> to -2 hex 2d32
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value -2 to I_Temp_SF
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h107
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h107: reading=C_Status, unpack=n, expr=, format=, map=1:Aus, 2:Nachtmodus, 4:Betrieb
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 0002 with n to 2 hex 32
2018.11.29 19:40:56 5: SE7K: MapConvert called from ModbusLD_ParseObj converted 2 to Nachtmodus with map 1:Aus, 2:Nachtmodus, 4:Betrieb
2018.11.29 19:40:56 5: SE7K: ParseObj for C_Status maps value 2 to Nachtmodus with 1:Aus, 2:Nachtmodus, 4:Betrieb
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value Nachtmodus to C_Status
2018.11.29 19:40:56 5: SE7K: HandleResponse got 16 readings from ParseObj for SE7K
2018.11.29 19:40:56 4: SE7K: ResponseDone, request: id 1, fCode 3, tid 1, type h, adr 71, len 37 for device SE7K reading I_AC_Strom, Current read buffer: 00010000004d01034a0000000000000000fffe000000000000092b0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002, Id 1, fCode 3, tid 1, response: id 1, fCode 3, type h, adr 71, len 37, value 0000000000000000fffe000000000000092b0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002
2018.11.29 19:40:56 5: SE7K: DropFrame - drop 00010000004d01034a0000000000000000fffe000000000000092b0932092effff000000001387fffe000000000000000000000000007f91d70000ffff80000000ffff000000008000000080008000fffe0002
2018.11.29 19:40:56 5: SE7K: StartQueueTimer called form Read sets internal timer to call Modbus_ProcessRequestQueue in 0.000 seconds
2018.11.29 19:40:56 5: SE7K: ProcessRequestQueue called from HandleTimeout as queue:SE7K
2018.11.29 19:40:56 5: SE7K: CheckDelay called from ProcessRequestQueue commDelay (0.1s since 19:40:56.406) for SE7K, delay over
2018.11.29 19:40:56 5: SE7K: CheckDelay called from ProcessRequestQueue sendDelay (0.1s since 19:40:56.363) for SE7K, delay over
2018.11.29 19:40:56 5: SE7K: PackRequest called from ProcessRequestQueue
2018.11.29 19:40:56 4: SE7K: ProcessRequestQueue got pdu from PackRequest: 0300140002
2018.11.29 19:40:56 5: SE7K: PackFrame called from ProcessRequestQueue id 1, tid 226, pdu 0300140002
2018.11.29 19:40:56 4: SE7K: ProcessRequestQueue (V4.0.17 - 10.11.2018) sending, request: id 1, fCode 3, tid 226, type h, adr 20, len 2 for device SE7K reading I_AC_Energie_year, read buffer empty
2018.11.29 19:40:56 5: SW: 00e200000006010300140002
2018.11.29 19:40:56 5: SE7K: StartQueueTimer called form ProcessRequestQueue sets internal timer to call Modbus_ProcessRequestQueue in 1.000 seconds
2018.11.29 19:40:56 5: SE7K: read buffer: 00e2000000070103045345374b
2018.11.29 19:40:56 5: SE7K: ParseFrameStart (TCP) extracted id 1, fCode 3, tid 226, dlen 7 and data 045345374b
2018.11.29 19:40:56 5: SE7K: HandleResponse called from Read
2018.11.29 19:40:56 5: SE7K: ParseResponse called from HandleResponse
2018.11.29 19:40:56 5: SE7K: HandleResponse now passing to logical device SE7K for parsing data
2018.11.29 19:40:56 5: SE7K: ParseObj called with data 5345374b, type h, adr 20, valuesLen 2, op read
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h20: reading=I_AC_Energie_year, unpack=n, expr=$val / 100, format=%.2f kWh, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 5345374b with n to 21317 hex 3231333137
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Energie_year, val=21317, expr=$val / 100
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 213.17
2018.11.29 19:40:56 5: SE7K: ParseObj for I_AC_Energie_year does sprintf with format %.2f kWh, value is 213.17
2018.11.29 19:40:56 5: SE7K: ParseObj for I_AC_Energie_year sprintf result is 213.17 kWh
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 213.17 kWh to I_AC_Energie_year
2018.11.29 19:40:56 5: SE7K: ParseObj moves to next object, skip 1 to h21
2018.11.29 19:40:56 5: SE7K: ParseObj ObjInfo for h21: reading=I_AC_Energie_month, unpack=n, expr=$val / 100, format=%.2f kWh, map=
2018.11.29 19:40:56 5: SE7K: ParseObj unpacked 374b with n to 14155 hex 3134313535
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_AC_Energie_month, val=14155, expr=$val / 100
2018.11.29 19:40:56 5: SE7K: CheckEval for ModbusLD_ParseObj result is 141.55
2018.11.29 19:40:56 5: SE7K: ParseObj for I_AC_Energie_month does sprintf with format %.2f kWh, value is 141.55
2018.11.29 19:40:56 5: SE7K: ParseObj for I_AC_Energie_month sprintf result is 141.55 kWh
2018.11.29 19:40:56 4: SE7K: ParseObj assigns value 141.55 kWh to I_AC_Energie_month
2018.11.29 19:40:56 5: SE7K: HandleResponse got 2 readings from ParseObj for SE7K
2018.11.29 19:40:56 4: SE7K: ResponseDone, request: id 1, fCode 3, tid 226, type h, adr 20, len 2 for device SE7K reading I_AC_Energie_year, Current read buffer: 00e2000000070103045345374b, Id 1, fCode 3, tid 226, response: id 1, fCode 3, type h, adr 20, len 2, value 5345374b
2018.11.29 19:40:56 5: SE7K: DropFrame - drop 00e2000000070103045345374b
2018.11.29 19:40:56 5: SE7K: StartQueueTimer called form Read sets internal timer to call Modbus_ProcessRequestQueue in 0.000 seconds
2018.11.29 19:40:57 5: SE7K: ProcessRequestQueue called from HandleTimeout as queue:SE7K
2018.11.29 19:40:57 5: SE7K: CheckDelay called from ProcessRequestQueue commDelay (0.1s since 19:40:56.901) for SE7K, delay over
2018.11.29 19:40:57 5: SE7K: CheckDelay called from ProcessRequestQueue sendDelay (0.1s since 19:40:56.889) for SE7K, delay over
2018.11.29 19:40:57 5: SE7K: PackRequest called from ProcessRequestQueue
2018.11.29 19:40:57 4: SE7K: ProcessRequestQueue got pdu from PackRequest: 03007b0004
2018.11.29 19:40:57 5: SE7K: PackFrame called from ProcessRequestQueue id 1, tid 19, pdu 03007b0004
2018.11.29 19:40:57 4: SE7K: ProcessRequestQueue (V4.0.17 - 10.11.2018) sending, request: id 1, fCode 3, tid 19, type h, adr 123, len 4 for device SE7K reading U_L1, read buffer empty
2018.11.29 19:40:57 5: SW: 0013000000060103007b0004
2018.11.29 19:40:57 5: SE7K: StartQueueTimer called from ProcessRequestQueue removes internal timer because it is not needed now
2018.11.29 19:40:57 5: SE7K: read buffer: 00130000000b010308576174744e6f6465
2018.11.29 19:40:57 5: SE7K: ParseFrameStart (TCP) extracted id 1, fCode 3, tid 19, dlen 11 and data 08576174744e6f6465
2018.11.29 19:40:57 5: SE7K: HandleResponse called from Read
2018.11.29 19:40:57 5: SE7K: ParseResponse called from HandleResponse
2018.11.29 19:40:57 5: SE7K: HandleResponse now passing to logical device SE7K for parsing data
2018.11.29 19:40:57 5: SE7K: ParseObj called with data 576174744e6f6465, type h, adr 123, valuesLen 4, op read
2018.11.29 19:40:57 5: SE7K: ParseObj ObjInfo for h123: reading=U_L1, unpack=n, expr=$val, format=, map=
2018.11.29 19:40:57 5: SE7K: ParseObj unpacked 576174744e6f6465 with n to 22369 hex 3232333639
2018.11.29 19:40:57 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for U_L1, val=22369, expr=$val
2018.11.29 19:40:57 5: SE7K: CheckEval for ModbusLD_ParseObj result is 22369
2018.11.29 19:40:57 4: SE7K: ParseObj assigns value 22369 to U_L1
2018.11.29 19:40:57 5: SE7K: ParseObj moves to next object, skip 1 to h124
2018.11.29 19:40:57 5: SE7K: ParseObj has no information about parsing h124
2018.11.29 19:40:57 5: SE7K: ParseObj moves to next object, skip 1 to h125
2018.11.29 19:40:57 5: SE7K: ParseObj has no information about parsing h125
2018.11.29 19:40:57 5: SE7K: ParseObj moves to next object, skip 1 to h126
2018.11.29 19:40:57 5: SE7K: ParseObj ObjInfo for h126: reading=I_L1, unpack=n, expr=$val, format=, map=
2018.11.29 19:40:57 5: SE7K: ParseObj unpacked 6465 with n to 25701 hex 3235373031
2018.11.29 19:40:57 5: SE7K: CheckEval for ModbusLD_ParseObj evaluates expr for I_L1, val=25701, expr=$val
2018.11.29 19:40:57 5: SE7K: CheckEval for ModbusLD_ParseObj result is 25701
2018.11.29 19:40:57 4: SE7K: ParseObj assigns value 25701 to I_L1
2018.11.29 19:40:57 5: SE7K: HandleResponse got 2 readings from ParseObj for SE7K

Tom_S · 29 November 2018, 22:44:56

und so geht es dann weiter

Code Auswählen


2018.11.29 20:27:55 4: SE7K: SetUpdateTimer updated timer - will call GetUpdate in 300.0 seconds at 2018-11-29 20:32:55 - Interval 300
2018.11.29 20:29:55 4: 192.168.115.15:502 disconnected, waiting to reappear (SE7K)
2018.11.29 20:29:55 5: HttpUtils url=http://192.168.115.15:502/
2018.11.29 20:29:55 4: 192.168.115.15:502 reappeared (SE7K)
2018.11.29 20:29:55 4: SE7K: SetUpdateTimer updated timer - will call GetUpdate in 300.0 seconds at 2018-11-29 20:34:55 - Interval 300
2018.11.29 20:31:55 4: 192.168.115.15:502 disconnected, waiting to reappear (SE7K)
2018.11.29 20:31:55 5: HttpUtils url=http://192.168.115.15:502/
2018.11.29 20:31:55 4: 192.168.115.15:502 reappeared (SE7K)
2018.11.29 20:31:55 4: SE7K: SetUpdateTimer updated timer - will call GetUpdate in 300.0 seconds at 2018-11-29 20:36:55 - Interval 300
2018.11.29 20:33:55 4: 192.168.115.15:502 disconnected, waiting to reappear (SE7K)
2018.11.29 20:33:55 5: HttpUtils url=http://192.168.115.15:502/
2018.11.29 20:33:55 4: 192.168.115.15:502 reappeared (SE7K)
2018.11.29 20:33:55 4: SE7K: SetUpdateTimer updated timer - will call GetUpdate in 300.0 seconds at 2018-11-29 20:38:55 - Interval 300
2018.11.29 20:35:55 4: 192.168.115.15:502 disconnected, waiting to reappear (SE7K)
2018.11.29 20:35:55 5: HttpUtils url=http://192.168.115.15:502/
2018.11.29 20:35:55 4: 192.168.115.15:502 reappeared (SE7K)

sorry, die Zeichen je Post sind wohl limitiert.

LG

pejonp · 29 November 2018, 23:11:21

@Tom_S,

Versuche einfach mal das andere Modul. Ist ja nur eine Zeile, wenn es nicht geht kannst du es ja ganz einfach wieder rausnehmen.

Mit

update all https://raw.githubusercontent.com/pejonp/FHEM---SolarEdge/master/controls_SolarEdge.txt

kannst du es runterladen und danach ein "shutdown restart".

Code Auswählen


defmod SE7k-Test SolarEdge 1 60 ip:502 TCP

pejonp

StefanStrobel · 30 November 2018, 08:52:33

Hallo Tom,

ich glaube Du bist da über eine Art race condition im neuen Modul gestolpert.
Das bringe ich übers Wochenende in Ordnung.

Auf den ersten Blick sieht das so aus, als ob das neue Modbus-Basis-Modul beim Öffnen der Verbindung den Update-Timer neu setzt - in Deinem Fall auf 5 Minuten. Vorher beendet aber der Slave die Verbindung. Das Modul baut sie dann wieder auf, setzt aber den Timer neu auf 5 Minuten und vor Ablauf dieser 5 Minuten greift wieder ein Disconnect-Timer im Slave und beendet die Verbindung. Das geht dann immer so weiter ...

Sorry und Danke für's Testen, Update kommt

Stefan

StefanStrobel · 02 Dezember 2018, 10:23:33

Hallo,

ich habe gerade eine neue Version (4.0.18) von 98_Modbus.pm eingecheckt, die das Problem mit dem Update-Timer beheben sollte.

Gruss
Stefan

Tom_S · 02 Dezember 2018, 23:50:41

Ich werde es morgen testen und berichten.
Danke

Tom_S · 03 Dezember 2018, 19:24:24

Ja oK. Es läuft.
nochmal Danke

holle75 · 09 Dezember 2018, 18:12:19

Hallo Stefan (denke mal als Entwickler bist du da die beste direkte Ansprechstelle),

Zitat von: holle75 am 20 November 2018, 15:51:45
TsTs, Angst abgelegt und einfach mal gemacht, was du geschrieben hast

Alle (die 2) H* gegen S> getauscht und funktioniert (zumindest ohne Fehlermeldungen beim starten).

Danke dir!

hier hatten wir ja gesprochen, aber so langsam wird mir klar, dass es wohl auch schon vor dem Update des Moduls das selbe (jetzt folgende) Problem gab, nur der Verbose-Wert ein anderer war für die entsprechende Fehlermeldung.

Ich bekomme, zu beachten: NUR WENN INTERNET DOWN, repetierend diese Fehlermeldung:

Code Auswählen

2018.12.09 12:25:40 3: Eastron: Timeout waiting for a modbus response, request: id 2, fCode 4, type i, adr 12, len 14 for device Xtender_AC_out reading Power__W, read buffer empty
2018.12.09 12:25:40 3: Eastron: read got new data while idle, drop buffer 02041c42fda3880000000000000000430926ea0000000000000000c250e707ee08
2018.12.09 12:25:51 3: Eastron: ResponseTimeout called, devhash=HASH(0x373c428), name of devhash=Xtender_AC_out
2018.12.09 12:25:51 3: Eastron: Timeout waiting for a modbus response, request: id 2, fCode 4, type i, adr 72, len 4 for device Xtender_AC_out reading Energy_import__kWh, read buffer empty
2018.12.09 12:25:51 3: Eastron: read got new data while idle, drop buffer 02040845cae03f00000000872f
2018.12.09 12:29:21 3: Eastron: ResponseTimeout called, devhash=HASH(0x359d220), name of devhash=Xtender_AC_in
2018.12.09 12:29:21 3: Eastron: Timeout waiting for a modbus response, request: id 1, fCode 4, type i, adr 12, len 2 for device Xtender_AC_in reading Power__W, read buffer empty
2018.12.09 12:29:21 3: Eastron: read got new data while idle, drop buffer 02040845cae050000000005326
2018.12.09 12:31:36 3: Eastron: ResponseTimeout called, devhash=HASH(0x373c428), name of devhash=Xtender_AC_out
2018.12.09 12:31:36 3: Eastron: Timeout waiting for a modbus response, request: id 2, fCode 4, type i, adr 72, len 4 for device Xtender_AC_out reading Energy_import__kWh, read buffer empty
2018.12.09 12:31:36 3: Eastron: read got new data while idle, drop buffer 02040845cae05800000000b2e7
2018.12.09 12:45:37 3: Eastron: ResponseTimeout called, devhash=HASH(0x373c428), name of devhash=Xtender_AC_out
2018.12.09 12:45:37 3: Eastron: Timeout waiting for a modbus response, request: id 2, fCode 4, type i, adr 344, len 2 for device Xtender_AC_out reading Energy_total__kVArh, read buffer empty
2018.12.09 13:09:09 3: Eastron: ResponseTimeout called, devhash=HASH(0x373c428), name of devhash=Xtender_AC_out
2018.12.09 13:09:09 3: Eastron: Timeout waiting for a modbus response, request: id 2, fCode 4, type i, adr 72, len 4 for device Xtender_AC_out reading Energy_import__kWh, read buffer empty
2018.12.09 13:09:09 3: Eastron: read got new data while idle, drop buffer 020404450742105d25
2018.12.09 13:29:49 3: Eastron: ResponseTimeout called, devhash=HASH(0x373c428), name of devhash=Xtender_AC_out
2018.12.09 13:29:49 3: Eastron: Timeout waiting for a modbus response, request: id 2, fCode 4, type i, adr 12, len 2 for device Xtender_AC_out reading Power__W, read buffer empty
2018.12.09 13:29:49 3: Eastron: read got new data while idle, drop buffer 02040442fab8c94e9b
2018.12.09 13:37:28 3: Eastron: ResponseTimeout called, devhash=HASH(0x373c428), name of devhash=Xtender_AC_out
2018.12.09 13:37:28 3: Eastron: Timeout waiting for a modbus response, request: id 2, fCode 4, type i, adr 6, len 8 for device Xtender_AC_out reading Current__A, read buffer empty
2018.12.09 13:37:28 3: Eastron: read got new data while idle, drop buffer 0204103f1eec70000000000000000042fb0434ea02
2018.12.09 13:39:48 3: Eastron: ResponseTimeout called, devhash=HASH(0x373c428), name of devhash=Xtender_AC_out
2018.12.09 13:39:48 3: Eastron: Timeout waiting for a modbus response, request: id 2, fCode 4, type i, adr 12, len 2 for device Xtender_AC_out reading Power__W, read buffer empty
2018.12.09 13:39:48 3: Eastron: read got new data while idle, drop buffer 02040442fc507820ee

Das selbe Problem (fhem "hängt" und die Daten kommen nicht an) übrigens mit meinem Homematic-HMLAN, aber das ist eine andere Baustelle. Nur zur Info.

Ist Modbus 100% NonBlocking? Wieso tritt dieser Fehler immer nur auf wenn mein Internet down ist? Oder umgedreht, kann es sein, dass ein anderes Modul blockt und das nur die Auswirkungen sind?

lieb Gruß
H.

StefanStrobel · 10 Dezember 2018, 20:26:57

Hallo Holle,

das Modbus-Modul ist komplett asynchron, solange Du keine get-Befehle verwendest, bei denen auf eine Antwort gewartet werden muss.
Was eventuell noch blocken könnte, sind Namensauflösungen.

Im Log sieht es so aus, als ob der Timeout zuschlägt und direkt danach die Daten ankommen und nicht mehr verarbeitet werden können, da der zugehörige Request bereits in den Timeout gelaufen ist.

Probier doch mal verbose auf 5 zu setzen und dann die Internet-Verbindung zu trennen, so dass wir im Log sehen, was tatsächlich passiert.

Gruss
Stefan

holle75 · 10 Dezember 2018, 21:59:55

Hallo Stefan und Danke für die Rückmeldung. Bin im Moment nicht vor Ort, melde mich aber, sobald ich wieder sinnvoll rankomme.

Grüße!
H.

elektro_rainer · 11 Dezember 2018, 09:42:38

Hallo zusammen,
Anfängerfrage:
in der alten Version hatte ich folgende Definition: "define modbus Modbus 192.168.xxx.xxx:502 tcp"
auf dieses Interface hat das ModbusTrovis Modul mit: "define modbustrovis ModbusTrovis5576 222 60 TCP"
zugegriffen, lief alles ohne Probleme.
Nach meinem letztem Update ist das modbus device einfach weg.
Ein neues modbus device mit: "define modbus Modbus IP adresse" krieg ich nicht definiert......
Ein neues modbus device mit: "define modbus ModbusAttr slave 10 60 192.168.xxx.xxx:502 TCP" steht zwar auf opened aber das modbusTrovis Modul bekommt keine Daten.
Hat jemand eine kreative Idee??

Danke und Grüße,
Rainer

StefanStrobel · 11 Dezember 2018, 23:06:52

Hallo Rainer,

Zitat von: elektro_rainer am 11 Dezember 2018, 09:42:38
in der alten Version hatte ich folgende Definition: "define modbus Modbus 192.168.xxx.xxx:502 tcp"
auf dieses Interface hat das ModbusTrovis Modul mit: "define modbustrovis ModbusTrovis5576 222 60 TCP"
zugegriffen, lief alles ohne Probleme.

Das klingt für mich nach einem Missverständnis. Auch in den älteren Versionen des Modbus-Moduls haben Fhem-Geräte Verbindungen per Modbus-TCP direkt aufgebaut. Nur bei Verbindungen über eine serielle Schnittstelle war und ist ein physisches Modbus-Fhem-Gerät nötig. Dein erstes "define modbus ..." war meiner Meinung nach immer schon sinnlos.

Zitat
Nach meinem letztem Update ist das modbus device einfach weg.

In der neuen Version musste ich das Parsen der define-Befehle im Modbus-Modul umbauen. Vermutlich ist das alte und überflüssige Gerät deshalb weg weil es jetzt korrekterweise eine Fehlermeldung erzeugt.
Mit der Funktion des ModbusTrovis-Moduls sollte das aber nichts zu tun haben.

Zitat
Ein neues modbus device mit: "define modbus Modbus IP adresse" krieg ich nicht definiert......

Das ist auch gut so, so ein Device macht auch keinen Sinn.

Zitat
Ein neues modbus device mit: "define modbus ModbusAttr slave 10 60 192.168.xxx.xxx:502 TCP" steht zwar auf opened aber das modbusTrovis Modul bekommt keine Daten.

Das wäre dann ein Modbus-Slave, der Anfagen von anderen Geräten im Netzwerk entgegen nehmen kann. Aber das ist etwas ganz anderes als das was du suchst ...

Zitat
Hat jemand eine kreative Idee??

Ich möchte nicht ausschließen, dass die neue Version des Modbus-Moduls ein Problem mit dem ModbusTrovis-Modul erzeugt. Um das zu klären könntest Du zunächst testweise wieder das alte Modbus-Modul einspielen. Wenn es damit funktioniert und mit dem neuen nicht, dann könntest Du das Attribut verbose für das Modbus-Trovis-Gerät auf 5 setzen und dann das Protokoll posten.
Daran kann ich dann hoffentlich erkennen, wo das Problem liegt.

Vielleicht lesen ja auch andere Anwender des Modbus-Trovis-Moduls mit und können berichten ob es bei Ihnen auch Probleme gibt ...

Gruß
Stefan

elektro_rainer · 12 Dezember 2018, 08:29:19

Hallo Stefan,

das modbus Modul ist Voraussetzung das das ModbusTrovis Modul läuft:
https://fhem.de/commandref_DE.html#ModbusTrovis5576
Vielleicht noch eine Ergänzung: FHEM spricht mit einem Modbus Gateway über IP zu meinem Trovis Regler.

Wie kommen wir nun weiter?

Danke und Grüße,
Rainer