@StefanStrobel
vielleicht kannst Du mir helfen eine elegante Lösung zu finden.
Im Augenblick versuche ich die Werte im ModbusAttr zu berechnen (wie Du es auch vorgeschlagen hast). Da aber der Wert und der Skalierungsfaktor in verschiedenen Readings sind kommen die ab und an durcheinander. Daher habe ich ein UserReadings geschrieben, das das beheben soll. Es scheint aber der Plan in einem UserReadings ein Reading erneut auszulesen scheitert.
Hier das ModbusAttr
Internals:
BUSY 0
DEF 1 30 192.168.178.36 TCP
DEST 192.168.178.36:502
DeviceName 192.168.178.36:502
FD 5
INTERVAL 60
IODev KeSolarEdge
LASTOPEN 1518979743.92579
MODBUSID 1
ModuleVersion 3.7.3 - 22.12.2017
NAME KeSolarEdge
NOTIFYDEV global
NR 363
NTFY_ORDER 50-KeSolarEdge
PARTIAL
PROTOCOL TCP
REQUESTHEX 002c0000000601039c8f0001
STATE opened
TRIGGERTIME 1518982148.23738
TRIGGERTIME_FMT 2018-02-18 20:29:08
TYPE ModbusAttr
devioLoglevel 3
nextOpenDelay 60
QUEUE:
READINGS:
2018-02-18 20:27:11 AC-Energy 502.548
2018-02-18 20:27:11 AC-Energy-Scale 0
2018-02-18 20:27:11 AC-Energy-Val 502548
2018-02-18 20:27:10 AC-Power 0
2018-02-18 20:27:11 AC-Power-Scale 0
2018-02-18 20:27:08 AC-Power-Val 0
2018-02-18 20:27:14 AC-Volt-A 232
2018-02-18 20:27:08 AC-Volt-Scale -1
2018-02-18 20:27:08 DC-Current 0
2018-02-18 20:27:08 DC-Current-Scale -32768
2018-02-18 20:27:08 DC-Current-Val 65535
2018-02-18 20:27:11 DC-Power 0
2018-02-18 20:27:11 DC-Power-Scale 0
2018-02-18 20:27:11 DC-Power-Val 0
2018-02-18 20:27:13 DC-Voltage 0
2018-02-18 20:27:13 DC-Voltage-Scale -1
2018-02-18 20:27:11 DC-Voltage-Val 0
2018-02-18 20:27:11 HeatSinkTemp 0
2018-02-18 20:27:10 Status 2
2018-02-18 19:49:03 state opened
defptr:
1:
gotReadings:
AC-Volt-A 232
helper:
buffer
lid 1
lrecv 1518982034.08556
lsend 1518982034.03397
lastRead:
h40079 1518982034.08912
h40082 1518982028.0878
h40083 1518982028.75169
h40084 1518982031.16065
h40093 1518982031.3014
h40095 1518982031.05454
h40096 1518982028.53803
h40097 1518982028.40507
h40098 1518982031.90755
h40099 1518982033.91931
h40100 1518982031.80175
h40101 1518982031.40754
h40103 1518982031.67835
h40107 1518982030.92108
Attributes:
dev-h-defPoll 1
dev-h-defShowGet 1
enableControlSet 1
maxTimeoutsToReconnect 3
obj-h40079-expr $val / 10
obj-h40079-reading AC-Volt-A
obj-h40082-reading AC-Volt-Scale
obj-h40082-unpack s>
obj-h40083-reading AC-Power-Val
obj-h40084-reading AC-Power-Scale
obj-h40084-unpack s>
obj-h40093-len 2
obj-h40093-reading AC-Energy-Val
obj-h40093-unpack l>
obj-h40095-reading AC-Energy-Scale
obj-h40096-reading DC-Current-Val
obj-h40097-reading DC-Current-Scale
obj-h40097-unpack s>
obj-h40098-reading DC-Voltage-Val
obj-h40099-reading DC-Voltage-Scale
obj-h40099-unpack s>
obj-h40100-reading DC-Power-Val
obj-h40101-reading DC-Power-Scale
obj-h40101-unpack s>
obj-h40103-reading HeatSinkTemp
obj-h40103-unpack s>
obj-h40107-reading Status
room Solar
userReadings AC-Energy:(AC-Energy-Val.*) {
my $scale;
if ((time_str2num(ReadingsTimestamp("KeSolarEdge","AC-Energy-Val",0)) - time_str2num(ReadingsTimestamp("KeSolarEdge","AC-Energy-Scale",0))) < 1) {
$scale = ReadingsVal ("KeSolarEdge","AC-Energy-Scale",0);
}
else {
$scale = fhem ("get KeSolarEdge AC-Energy-Scale");
}
return (ReadingsVal ("KeSolarEdge","AC-Energy-Val",0) * ( 10 ** $scale) / 1000);;},
AC-Power:(AC-Power-Val.*) {
my $scale;
if ((time_str2num(ReadingsTimestamp("KeSolarEdge","AC-Power-Val",0)) - time_str2num(ReadingsTimestamp("KeSolarEdge","AC-Power-Scale",0))) < 1) {
$scale = ReadingsVal ("KeSolarEdge","AC-Power-Scale",0);
}
else {
$scale = fhem ("get KeSolarEdge AC-Power-Scale");
}
return (ReadingsVal ("KeSolarEdge","AC-Power-Val",0) * ( 10 ** $scale) / 1000);;},
DC-Power:(DC-Power-Val.*) {
my $scale;
if ((time_str2num(ReadingsTimestamp("KeSolarEdge","DC-Power-Val",0)) - time_str2num(ReadingsTimestamp("KeSolarEdge","DC-Power-Scale",0))) < 1) {
$scale = ReadingsVal ("KeSolarEdge","DC-Power-Scale",0);
}
else {
$scale = fhem ("get KeSolarEdge DC-Power-Scale");
}
return (ReadingsVal ("KeSolarEdge","DC-Power-Val",0) * ( 10 ** $scale) / 1000);;},
DC-Current:(DC-Current-Val.*) {
my $scale;
if ((time_str2num(ReadingsTimestamp("KeSolarEdge","DC-Current-Val",0)) - time_str2num(ReadingsTimestamp("KeSolarEdge","DC-Current-Scale",0))) < 1) {
$scale = ReadingsVal ("KeSolarEdge","DC-Current-Scale",0);
}
else {
$scale = fhem ("get KeSolarEdge DC-Current-Scale");
}
return (ReadingsVal ("KeSolarEdge","DC-Current-Val",0) * ( 10 ** $scale) / 1000);;},
DC-Voltage:(DC-Voltage-Val.*) {
my $scale;
if ((time_str2num(ReadingsTimestamp("KeSolarEdge","DC-Voltage-Val",0)) - time_str2num(ReadingsTimestamp("KeSolarEdge","DC-Voltage-Scale",0))) < 1) {
$scale = ReadingsVal ("KeSolarEdge","DC-Voltage-Scale",0);
}
else {
$scale = fhem ("get KeSolarEdge DC-Voltage-Scale");
}
return (ReadingsVal ("KeSolarEdge","DC-Voltage-Val",0) * ( 10 ** $scale) / 1000);;}
userattr dev-h-defPoll dev-h-defShowGet enableControlSet maxTimeoutsToReconnect obj-h40079-expr obj-h40079-reading obj-h40082-reading obj-h40082-unpack obj-h40083-reading obj-h40084-expr obj-h40084-reading obj-h40084-unpack obj-h40093-len obj-h40093-reading obj-h40093-unpack obj-h40094-poll obj-h40094-reading obj-h40095-reading obj-h40096-reading obj-h40097-reading obj-h40097-unpack obj-h40098-reading obj-h40099-reading obj-h40099-unpack obj-h40100-reading obj-h40101-reading obj-h40101-unpack obj-h40103-reading obj-h40103-unpack obj-h40107-reading obj-h40108-reading silentReconnect userReadings verbose
verbose 5
und hier das log:
2018.02.18 20:40:10 1: opened
2018.02.18 20:40:10 3: KeSolarEdge: timer interval changed to 60 seconds
2018.02.18 20:40:10 4: KeSolarEdge: update timer modified: will call GetUpdate in 60.0 seconds at 2018-02-18 20:41:10 - Interval 60
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate called
2018.02.18 20:41:10 4: KeSolarEdge: update timer modified: will call GetUpdate in 60.0 seconds at 2018-02-18 20:42:10 - Interval 60
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate objects from attributes: h40103 h40098 h40084 h40097 h40099 h40083 h40100 h40093 h40101 h40096 h40107 h40095 h40079 h40082
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate full object list: h40079 h40082 h40083 h40084 h40093 h40095 h40096 h40097 h40098 h40099 h40100 h40101 h40103 h40107
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40079 => AC-Volt-A, poll = 1, last = 1518982756.19274
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request AC-Volt-A
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40082 => AC-Volt-Scale, poll = 1, last = 1518982750.50473
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request AC-Volt-Scale
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40083 => AC-Power-Val, poll = 1, last = 1518982750.96171
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request AC-Power-Val
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40084 => AC-Power-Scale, poll = 1, last = 1518982753.36003
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request AC-Power-Scale
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40093 => AC-Energy-Val, poll = 1, last = 1518982753.47444
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request AC-Energy-Val
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40095 => AC-Energy-Scale, poll = 1, last = 1518982753.23631
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request AC-Energy-Scale
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40096 => DC-Current-Val, poll = 1, last = 1518982750.73297
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request DC-Current-Val
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40097 => DC-Current-Scale, poll = 1, last = 1518982750.6206
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request DC-Current-Scale
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40098 => DC-Voltage-Val, poll = 1, last = 1518982754.02033
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request DC-Voltage-Val
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40099 => DC-Voltage-Scale, poll = 1, last = 1518982756.04443
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request DC-Voltage-Scale
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40100 => DC-Power-Val, poll = 1, last = 1518982753.91049
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request DC-Power-Val
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40101 => DC-Power-Scale, poll = 1, last = 1518982753.616
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request DC-Power-Scale
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40103 => HeatSinkTemp, poll = 1, last = 1518982753.73013
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request HeatSinkTemp
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate check h40107 => Status, poll = 1, last = 1518982753.12422
2018.02.18 20:41:10 4: KeSolarEdge: GetUpdate will request Status
2018.02.18 20:41:10 5: KeSolarEdge: GetUpdate tries to combine read commands
2018.02.18 20:41:10 5: KeSolarEdge: No Combine AC-Volt-A / h40079 with AC-Volt-Scale / h40082, span 4 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine AC-Volt-Scale / h40082 with AC-Power-Val / h40083, span 2 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine AC-Power-Val / h40083 with AC-Power-Scale / h40084, span 2 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine AC-Power-Scale / h40084 with AC-Energy-Val / h40093, span 11 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine AC-Energy-Val / h40093 with AC-Energy-Scale / h40095, span 3 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine AC-Energy-Scale / h40095 with DC-Current-Val / h40096, span 2 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine DC-Current-Val / h40096 with DC-Current-Scale / h40097, span 2 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine DC-Current-Scale / h40097 with DC-Voltage-Val / h40098, span 2 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine DC-Voltage-Val / h40098 with DC-Voltage-Scale / h40099, span 2 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine DC-Voltage-Scale / h40099 with DC-Power-Val / h40100, span 2 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine DC-Power-Val / h40100 with DC-Power-Scale / h40101, span 2 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine DC-Power-Scale / h40101 with HeatSinkTemp / h40103, span 3 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: No Combine HeatSinkTemp / h40103 with Status / h40107, span 5 > max 1
2018.02.18 20:41:10 5: KeSolarEdge: don't sort objList before sending requests
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40082, objLen 1 / reqLen 1 to id 1, op read, qlen 0
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 187, for h40082 (AC-Volt-Scale), reqLen 1
2018.02.18 20:41:10 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -114.34584903717
2018.02.18 20:41:10 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -114.351452112198
2018.02.18 20:41:10 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:10 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 187 for AC-Volt-Scale (h40082), len 1, device KeSolarEdge (TCP), pdu 039c920001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:10 5: SW: 00bb0000000601039c920001
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40097, objLen 1 / reqLen 1 to id 1, op read, qlen 0
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 31, for h40097 (DC-Current-Scale), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40096, objLen 1 / reqLen 1 to id 1, op read, qlen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 48, for h40096 (DC-Current-Val), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40099, objLen 1 / reqLen 1 to id 1, op read, qlen 2
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 23, for h40099 (DC-Voltage-Scale), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40083, objLen 1 / reqLen 1 to id 1, op read, qlen 3
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 111, for h40083 (AC-Power-Val), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40107, objLen 1 / reqLen 1 to id 1, op read, qlen 4
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 198, for h40107 (Status), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40095, objLen 1 / reqLen 1 to id 1, op read, qlen 5
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 221, for h40095 (AC-Energy-Scale), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40084, objLen 1 / reqLen 1 to id 1, op read, qlen 6
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 118, for h40084 (AC-Power-Scale), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40093, objLen 2 / reqLen 2 to id 1, op read, qlen 7
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 40, for h40093 (AC-Energy-Val), reqLen 2
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40101, objLen 1 / reqLen 1 to id 1, op read, qlen 8
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 152, for h40101 (DC-Power-Scale), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40103, objLen 1 / reqLen 1 to id 1, op read, qlen 9
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 43, for h40103 (HeatSinkTemp), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40100, objLen 1 / reqLen 1 to id 1, op read, qlen 10
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 116, for h40100 (DC-Power-Val), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40098, objLen 1 / reqLen 1 to id 1, op read, qlen 11
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 36, for h40098 (DC-Voltage-Val), reqLen 1
2018.02.18 20:41:10 4: KeSolarEdge: Send called with h40079, objLen 1 / reqLen 1 to id 1, op read, qlen 12
2018.02.18 20:41:10 4: KeSolarEdge: Send queues fc 3 to 1, tid 82, for h40079 (AC-Volt-A), reqLen 1
2018.02.18 20:41:10 5: KeSolarEdge: raw read: 00bb00000005010302ffff
2018.02.18 20:41:10 5: KeSolarEdge: ParseFrames got: 00bb00000005010302ffff
2018.02.18 20:41:10 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 187, values ffffHeaderLen 2, ActualLen 2, request was for h40082 (AC-Volt-Scale), len 1 for module KeSolarEdge
2018.02.18 20:41:10 5: KeSolarEdge: ParseObj called with ffff and start 40082, op read
2018.02.18 20:41:10 5: KeSolarEdge: ParseObj ObjInfo for h40082: reading=AC-Volt-Scale, unpack=s>, expr=, format=, map=
2018.02.18 20:41:10 5: KeSolarEdge: ParseObj unpacked ffff with s> to hex 2d31 (-1)
2018.02.18 20:41:10 4: KeSolarEdge: ParseObj for AC-Volt-Scale assigns -1
2018.02.18 20:41:10 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:10 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0583937168121338
2018.02.18 20:41:10 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0583937168121338
2018.02.18 20:41:10 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.00193524360656738
2018.02.18 20:41:10 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.0510880947113037
2018.02.18 20:41:10 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:10 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 31 for DC-Current-Scale (h40097), len 1, device KeSolarEdge (TCP), pdu 039ca10001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:10 5: SW: 001f0000000601039ca10001
2018.02.18 20:41:10 5: KeSolarEdge: raw read: 001f000000050103028000
2018.02.18 20:41:10 5: KeSolarEdge: ParseFrames got: 001f000000050103028000
2018.02.18 20:41:10 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 31, values 8000HeaderLen 2, ActualLen 2, request was for h40097 (DC-Current-Scale), len 1 for module KeSolarEdge
2018.02.18 20:41:10 5: KeSolarEdge: ParseObj called with 8000 and start 40097, op read
2018.02.18 20:41:10 5: KeSolarEdge: ParseObj ObjInfo for h40097: reading=DC-Current-Scale, unpack=s>, expr=, format=, map=
2018.02.18 20:41:10 5: KeSolarEdge: ParseObj unpacked 8000 with s> to hex 2d3332373638 (-32768)
2018.02.18 20:41:10 4: KeSolarEdge: ParseObj for DC-Current-Scale assigns -32768
2018.02.18 20:41:10 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:10 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.058297872543335
2018.02.18 20:41:10 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.058297872543335
2018.02.18 20:41:10 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.00185203552246094
2018.02.18 20:41:10 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.00827193260192871
2018.02.18 20:41:10 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:10 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 48 for DC-Current-Val (h40096), len 1, device KeSolarEdge (TCP), pdu 039ca00001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:10 5: SW: 00300000000601039ca00001
2018.02.18 20:41:10 5: KeSolarEdge: raw read: 003000000005010302ffff
2018.02.18 20:41:10 5: KeSolarEdge: ParseFrames got: 003000000005010302ffff
2018.02.18 20:41:10 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 48, values ffffHeaderLen 2, ActualLen 2, request was for h40096 (DC-Current-Val), len 1 for module KeSolarEdge
2018.02.18 20:41:10 5: KeSolarEdge: ParseObj called with ffff and start 40096, op read
2018.02.18 20:41:10 5: KeSolarEdge: ParseObj ObjInfo for h40096: reading=DC-Current-Val, unpack=n, expr=, format=, map=
2018.02.18 20:41:10 5: KeSolarEdge: ParseObj unpacked ffff with n to hex 3635353335 (65535)
2018.02.18 20:41:10 4: KeSolarEdge: ParseObj for DC-Current-Val assigns 65535
2018.02.18 20:41:10 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:10 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0472698211669922
2018.02.18 20:41:10 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0472698211669922
2018.02.18 20:41:11 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.00162911415100098
2018.02.18 20:41:11 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.0106191635131836
2018.02.18 20:41:11 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:11 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 23 for DC-Voltage-Scale (h40099), len 1, device KeSolarEdge (TCP), pdu 039ca30001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:11 5: SW: 00170000000601039ca30001
2018.02.18 20:41:11 5: KeSolarEdge: raw read: 001700000005010302ffff
2018.02.18 20:41:11 5: KeSolarEdge: ParseFrames got: 001700000005010302ffff
2018.02.18 20:41:11 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 23, values ffffHeaderLen 2, ActualLen 2, request was for h40099 (DC-Voltage-Scale), len 1 for module KeSolarEdge
2018.02.18 20:41:11 5: KeSolarEdge: ParseObj called with ffff and start 40099, op read
2018.02.18 20:41:11 5: KeSolarEdge: ParseObj ObjInfo for h40099: reading=DC-Voltage-Scale, unpack=s>, expr=, format=, map=
2018.02.18 20:41:11 5: KeSolarEdge: ParseObj unpacked ffff with s> to hex 2d31 (-1)
2018.02.18 20:41:11 4: KeSolarEdge: ParseObj for DC-Voltage-Scale assigns -1
2018.02.18 20:41:11 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:11 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0583548545837402
2018.02.18 20:41:11 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0583548545837402
2018.02.18 20:41:11 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.00166416168212891
2018.02.18 20:41:11 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.00785589218139648
2018.02.18 20:41:11 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:11 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 111 for AC-Power-Val (h40083), len 1, device KeSolarEdge (TCP), pdu 039c930001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:11 5: SW: 006f0000000601039c930001
2018.02.18 20:41:11 5: KeSolarEdge: raw read: 006f000000050103020000
2018.02.18 20:41:11 5: KeSolarEdge: ParseFrames got: 006f000000050103020000
2018.02.18 20:41:11 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 111, values 0000HeaderLen 2, ActualLen 2, request was for h40083 (AC-Power-Val), len 1 for module KeSolarEdge
2018.02.18 20:41:11 5: KeSolarEdge: ParseObj called with 0000 and start 40083, op read
2018.02.18 20:41:11 5: KeSolarEdge: ParseObj ObjInfo for h40083: reading=AC-Power-Val, unpack=n, expr=, format=, map=
2018.02.18 20:41:11 5: KeSolarEdge: ParseObj unpacked 0000 with n to hex 30 (0)
2018.02.18 20:41:11 4: KeSolarEdge: ParseObj for AC-Power-Val assigns 0
2018.02.18 20:41:11 5: KeSolarEdge: Get: Called with AC-Power-Scale (h40084)
2018.02.18 20:41:11 5: KeSolarEdge: Get: Queue is stil busy - taking over the read with ReadAnswer
2018.02.18 20:41:11 5: KeSolarEdge: ReadAnswer called and remaining timeout is 1.97947597503662
2018.02.18 20:41:13 3: KeSolarEdge: Timeout2 in ReadAnswer
2018.02.18 20:41:13 4: KeSolarEdge: Send called with h40084, objLen 1 / reqLen - to id 1, op read, qlen 9
2018.02.18 20:41:13 4: KeSolarEdge: Send adds fc 3 to 1, tid 253, for h40084 (AC-Power-Scale), reqLen 1 at beginning of queue for immediate sending
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -1.89980792999268
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -1.91000914573669
2018.02.18 20:41:13 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 253 for AC-Power-Scale (h40084), len 1, device KeSolarEdge (TCP), pdu 039c940001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:13 5: SW: 00fd0000000601039c940001
2018.02.18 20:41:13 5: KeSolarEdge: ReadAnswer called and remaining timeout is 1.99929404258728 requested reading is AC-Power-Scale
2018.02.18 20:41:13 5: KeSolarEdge: ReadAnswer got: 00fd000000050103020000
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got: 00fd000000050103020000
2018.02.18 20:41:13 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 253, values 0000HeaderLen 2, ActualLen 2, request was for h40084 (AC-Power-Scale), len 1 for module KeSolarEdge
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj called with 0000 and start 40084, op read
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj ObjInfo for h40084: reading=AC-Power-Scale, unpack=s>, expr=, format=, map=
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj unpacked 0000 with s> to hex 30 (0)
2018.02.18 20:41:13 4: KeSolarEdge: ParseObj for AC-Power-Scale assigns 0
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:13 5: KeSolarEdge: ReadAnswer done, reading is AC-Power-Scale, value: 0
2018.02.18 20:41:13 1: readingsUpdate(KeSolarEdge,AC-Power,0) missed to call readingsBeginUpdate first.
2018.02.18 20:41:13 1: stacktrace:
2018.02.18 20:41:13 1: main::readingsBulkUpdate called by fhem.pl (4400)
2018.02.18 20:41:13 1: main::readingsEndUpdate called by ./FHEM/98_Modbus.pm (666)
2018.02.18 20:41:13 1: main::Modbus_ParseObj called by ./FHEM/98_Modbus.pm (963)
2018.02.18 20:41:13 1: main::Modbus_ParseFrames called by ./FHEM/98_Modbus.pm (1012)
2018.02.18 20:41:13 1: main::Modbus_Read called by fhem.pl (3510)
2018.02.18 20:41:13 1: main::CallFn called by fhem.pl (689)
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0292308330535889
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0292308330535889
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.219043254852295
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.22862720489502
2018.02.18 20:41:13 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 198 for Status (h40107), len 1, device KeSolarEdge (TCP), pdu 039cab0001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:13 5: SW: 00c60000000601039cab0001
2018.02.18 20:41:13 5: KeSolarEdge: raw read: 00c6000000050103020002
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got: 00c6000000050103020002
2018.02.18 20:41:13 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 198, values 0002HeaderLen 2, ActualLen 2, request was for h40107 (Status), len 1 for module KeSolarEdge
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj called with 0002 and start 40107, op read
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj ObjInfo for h40107: reading=Status, unpack=n, expr=, format=, map=
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj unpacked 0002 with n to hex 32 (2)
2018.02.18 20:41:13 4: KeSolarEdge: ParseObj for Status assigns 2
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0571830272674561
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0571830272674561
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.0709049701690674
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.0795319080352783
2018.02.18 20:41:13 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 221 for AC-Energy-Scale (h40095), len 1, device KeSolarEdge (TCP), pdu 039c9f0001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:13 5: SW: 00dd0000000601039c9f0001
2018.02.18 20:41:13 5: KeSolarEdge: raw read: 00dd000000050103020000
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got: 00dd000000050103020000
2018.02.18 20:41:13 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 221, values 0000HeaderLen 2, ActualLen 2, request was for h40095 (AC-Energy-Scale), len 1 for module KeSolarEdge
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj called with 0000 and start 40095, op read
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj ObjInfo for h40095: reading=AC-Energy-Scale, unpack=n, expr=, format=, map=
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj unpacked 0000 with n to hex 30 (0)
2018.02.18 20:41:13 4: KeSolarEdge: ParseObj for AC-Energy-Scale assigns 0
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0579907894134521
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0579907894134521
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.00177311897277832
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.00716304779052734
2018.02.18 20:41:13 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 118 for AC-Power-Scale (h40084), len 1, device KeSolarEdge (TCP), pdu 039c940001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:13 5: SW: 00760000000601039c940001
2018.02.18 20:41:13 5: KeSolarEdge: raw read: 0076000000050103020000
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got: 0076000000050103020000
2018.02.18 20:41:13 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 118, values 0000HeaderLen 2, ActualLen 2, request was for h40084 (AC-Power-Scale), len 1 for module KeSolarEdge
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj called with 0000 and start 40084, op read
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj ObjInfo for h40084: reading=AC-Power-Scale, unpack=s>, expr=, format=, map=
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj unpacked 0000 with s> to hex 30 (0)
2018.02.18 20:41:13 4: KeSolarEdge: ParseObj for AC-Power-Scale assigns 0
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0597178936004639
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0597178936004639
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.00194787979125977
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.00683927536010742
2018.02.18 20:41:13 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 40 for AC-Energy-Val (h40093), len 2, device KeSolarEdge (TCP), pdu 039c9d0002, V 3.7.3 - 22.12.2017
2018.02.18 20:41:13 5: SW: 00280000000601039c9d0002
2018.02.18 20:41:13 5: KeSolarEdge: raw read: 0028000000070103040007ab14
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got: 0028000000070103040007ab14
2018.02.18 20:41:13 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 40, values 0007ab14HeaderLen 4, ActualLen 4, request was for h40093 (AC-Energy-Val), len 2 for module KeSolarEdge
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj called with 0007ab14 and start 40093, op read
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj ObjInfo for h40093: reading=AC-Energy-Val, unpack=l>, expr=, format=, map=
2018.02.18 20:41:13 5: KeSolarEdge: ParseObj unpacked 0007ab14 with l> to hex 353032353438 (502548)
2018.02.18 20:41:13 4: KeSolarEdge: ParseObj for AC-Energy-Val assigns 502548
2018.02.18 20:41:13 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0485069751739502
2018.02.18 20:41:13 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0485069751739502
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.00170207023620605
2018.02.18 20:41:13 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.0117151737213135
2018.02.18 20:41:14 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:14 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 152 for DC-Power-Scale (h40101), len 1, device KeSolarEdge (TCP), pdu 039ca50001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:14 5: SW: 00980000000601039ca50001
2018.02.18 20:41:14 5: KeSolarEdge: raw read: 0098000000050103020000
2018.02.18 20:41:14 5: KeSolarEdge: ParseFrames got: 0098000000050103020000
2018.02.18 20:41:14 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 152, values 0000HeaderLen 2, ActualLen 2, request was for h40101 (DC-Power-Scale), len 1 for module KeSolarEdge
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj called with 0000 and start 40101, op read
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj ObjInfo for h40101: reading=DC-Power-Scale, unpack=s>, expr=, format=, map=
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj unpacked 0000 with s> to hex 30 (0)
2018.02.18 20:41:14 4: KeSolarEdge: ParseObj for DC-Power-Scale assigns 0
2018.02.18 20:41:14 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:14 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0594909191131592
2018.02.18 20:41:14 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0594909191131592
2018.02.18 20:41:14 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.00170707702636719
2018.02.18 20:41:14 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.00838208198547363
2018.02.18 20:41:14 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:14 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 43 for HeatSinkTemp (h40103), len 1, device KeSolarEdge (TCP), pdu 039ca70001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:14 5: SW: 002b0000000601039ca70001
2018.02.18 20:41:14 5: KeSolarEdge: raw read: 002b000000050103020000
2018.02.18 20:41:14 5: KeSolarEdge: ParseFrames got: 002b000000050103020000
2018.02.18 20:41:14 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 43, values 0000HeaderLen 2, ActualLen 2, request was for h40103 (HeatSinkTemp), len 1 for module KeSolarEdge
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj called with 0000 and start 40103, op read
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj ObjInfo for h40103: reading=HeatSinkTemp, unpack=s>, expr=, format=, map=
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj unpacked 0000 with s> to hex 30 (0)
2018.02.18 20:41:14 4: KeSolarEdge: ParseObj for HeatSinkTemp assigns 0
2018.02.18 20:41:14 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:14 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0591778755187988
2018.02.18 20:41:14 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0591778755187988
2018.02.18 20:41:14 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.00171399116516113
2018.02.18 20:41:14 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.0105290412902832
2018.02.18 20:41:14 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:14 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 116 for DC-Power-Val (h40100), len 1, device KeSolarEdge (TCP), pdu 039ca40001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:14 5: SW: 00740000000601039ca40001
2018.02.18 20:41:14 5: KeSolarEdge: raw read: 0074000000050103020000
2018.02.18 20:41:14 5: KeSolarEdge: ParseFrames got: 0074000000050103020000
2018.02.18 20:41:14 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 116, values 0000HeaderLen 2, ActualLen 2, request was for h40100 (DC-Power-Val), len 1 for module KeSolarEdge
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj called with 0000 and start 40100, op read
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj ObjInfo for h40100: reading=DC-Power-Val, unpack=n, expr=, format=, map=
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj unpacked 0000 with n to hex 30 (0)
2018.02.18 20:41:14 4: KeSolarEdge: ParseObj for DC-Power-Val assigns 0
2018.02.18 20:41:14 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:14 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0483968257904053
2018.02.18 20:41:14 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0483968257904053
2018.02.18 20:41:14 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.0018310546875
2018.02.18 20:41:14 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.0109779834747314
2018.02.18 20:41:14 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:14 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 36 for DC-Voltage-Val (h40098), len 1, device KeSolarEdge (TCP), pdu 039ca20001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:14 5: SW: 00240000000601039ca20001
2018.02.18 20:41:14 5: KeSolarEdge: raw read: 0024000000050103020000
2018.02.18 20:41:14 5: KeSolarEdge: ParseFrames got: 0024000000050103020000
2018.02.18 20:41:14 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 36, values 0000HeaderLen 2, ActualLen 2, request was for h40098 (DC-Voltage-Val), len 1 for module KeSolarEdge
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj called with 0000 and start 40098, op read
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj ObjInfo for h40098: reading=DC-Voltage-Val, unpack=n, expr=, format=, map=
2018.02.18 20:41:14 5: KeSolarEdge: ParseObj unpacked 0000 with n to hex 30 (0)
2018.02.18 20:41:14 4: KeSolarEdge: ParseObj for DC-Voltage-Val assigns 0
2018.02.18 20:41:14 5: KeSolarEdge: Get: Called with DC-Voltage-Scale (h40099)
2018.02.18 20:41:14 5: KeSolarEdge: Get: Queue is stil busy - taking over the read with ReadAnswer
2018.02.18 20:41:14 5: KeSolarEdge: ReadAnswer called and remaining timeout is 1.96346211433411
2018.02.18 20:41:16 3: KeSolarEdge: Timeout2 in ReadAnswer
2018.02.18 20:41:16 4: KeSolarEdge: Send called with h40099, objLen 1 / reqLen - to id 1, op read, qlen 1
2018.02.18 20:41:16 4: KeSolarEdge: Send adds fc 3 to 1, tid 54, for h40099 (DC-Voltage-Scale), reqLen 1 at beginning of queue for immediate sending
2018.02.18 20:41:16 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -1.88453221321106
2018.02.18 20:41:16 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -1.91278004646301
2018.02.18 20:41:16 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:16 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 54 for DC-Voltage-Scale (h40099), len 1, device KeSolarEdge (TCP), pdu 039ca30001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:16 5: SW: 00360000000601039ca30001
2018.02.18 20:41:16 5: KeSolarEdge: ReadAnswer called and remaining timeout is 1.99891805648804 requested reading is DC-Voltage-Scale
2018.02.18 20:41:16 5: KeSolarEdge: ReadAnswer got: 003600000005010302ffff
2018.02.18 20:41:16 5: KeSolarEdge: ParseFrames got: 003600000005010302ffff
2018.02.18 20:41:16 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 54, values ffffHeaderLen 2, ActualLen 2, request was for h40099 (DC-Voltage-Scale), len 1 for module KeSolarEdge
2018.02.18 20:41:16 5: KeSolarEdge: ParseObj called with ffff and start 40099, op read
2018.02.18 20:41:16 5: KeSolarEdge: ParseObj ObjInfo for h40099: reading=DC-Voltage-Scale, unpack=s>, expr=, format=, map=
2018.02.18 20:41:16 5: KeSolarEdge: ParseObj unpacked ffff with s> to hex 2d31 (-1)
2018.02.18 20:41:16 4: KeSolarEdge: ParseObj for DC-Voltage-Scale assigns -1
2018.02.18 20:41:16 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:16 5: KeSolarEdge: ReadAnswer done, reading is DC-Voltage-Scale, value: -1
2018.02.18 20:41:16 3: get KeSolarEdge DC-Voltage-Scale : -1
2018.02.18 20:41:16 1: readingsUpdate(KeSolarEdge,DC-Voltage,0) missed to call readingsBeginUpdate first.
2018.02.18 20:41:16 1: stacktrace:
2018.02.18 20:41:16 1: main::readingsBulkUpdate called by fhem.pl (4400)
2018.02.18 20:41:16 1: main::readingsEndUpdate called by ./FHEM/98_Modbus.pm (666)
2018.02.18 20:41:16 1: main::Modbus_ParseObj called by ./FHEM/98_Modbus.pm (963)
2018.02.18 20:41:16 1: main::Modbus_ParseFrames called by ./FHEM/98_Modbus.pm (1012)
2018.02.18 20:41:16 1: main::Modbus_Read called by fhem.pl (3510)
2018.02.18 20:41:16 1: main::CallFn called by fhem.pl (689)
2018.02.18 20:41:16 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
2018.02.18 20:41:16 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest 0.0242378711700439
2018.02.18 20:41:16 4: KeSolarEdge: HandleSendQueue / CheckDelay commDelay (0.1) for KeSolarEdge not over, try again in 0.0242378711700439
2018.02.18 20:41:16 5: KeSolarEdge: handle queue check commDelay (0.1) for KeSolarEdge: rest -0.377182245254517
2018.02.18 20:41:16 5: KeSolarEdge: handle queue check sendDelay (0.1) for KeSolarEdge: rest -0.392017126083374
2018.02.18 20:41:16 5: KeSolarEdge: HandleSendQueue: finished delay checking, proceed with sending
2018.02.18 20:41:16 4: KeSolarEdge: HandleSendQueue sends fc 3 to id 1, tid 82 for AC-Volt-A (h40079), len 1, device KeSolarEdge (TCP), pdu 039c8f0001, V 3.7.3 - 22.12.2017
2018.02.18 20:41:16 5: SW: 00520000000601039c8f0001
2018.02.18 20:41:16 5: KeSolarEdge: raw read: 00520000000501030208f0
2018.02.18 20:41:16 5: KeSolarEdge: ParseFrames got: 00520000000501030208f0
2018.02.18 20:41:16 4: KeSolarEdge: ParseFrames got fcode 3 from 1, tid 82, values 08f0HeaderLen 2, ActualLen 2, request was for h40079 (AC-Volt-A), len 1 for module KeSolarEdge
2018.02.18 20:41:16 5: KeSolarEdge: ParseObj called with 08f0 and start 40079, op read
2018.02.18 20:41:16 5: KeSolarEdge: ParseObj ObjInfo for h40079: reading=AC-Volt-A, unpack=n, expr=$val / 10, format=, map=
2018.02.18 20:41:16 5: KeSolarEdge: ParseObj unpacked 08f0 with n to hex 32323838 (2288)
2018.02.18 20:41:16 5: KeSolarEdge: ParseObj evaluates expr for AC-Volt-A, val=2288, expr $val / 10
2018.02.18 20:41:16 5: KeSolarEdge: ParseObj eval result is 228.8
2018.02.18 20:41:16 4: KeSolarEdge: ParseObj for AC-Volt-A assigns 228.8
2018.02.18 20:41:16 5: KeSolarEdge: ParseFrames got 1 readings from ParseObj
ich bitte mir vor allem mit den Meldungen vom Typ:
2018.02.18 20:41:13 1: readingsUpdate(KeSolarEdge,AC-Power,0) missed to call readingsBeginUpdate first
zu helfen