Neues Modul für Geräte mit Modbus Schnittstelle über RS232 bzw. RS485

Begonnen von StefanStrobel, 12 Juli 2014, 14:50:22

Vorheriges Thema - Nächstes Thema

Roger

Hi,
ich habe für die Stromzähler SDM220M und SDM630M nun ein eigenes Thema aufgemacht:
http://forum.fhem.de/index.php/topic,50196.0.html
Dort kann man im ersten Beitrag immer die aktuellen Module finden.
- nun ohne %-Zeichen in den Readings-Namen

Roger
Zotac & RPIs mit 10*FHEM
2*HM-LAN, 2*JeeLink, 2*RS485, SignalESP
HomeMatic, PCA301 Komponenten, ModBus: Stromzähler, Fronius WR, Shelly, Victron

StefanStrobel

Hallo Reiner,

Ich setze das auf die Wunschliste für die nächste Version.
Sollte kein großer Aufwnd sein.

Gruß
    Stefan

mkunst

Hallo,

Ich habe auf Basis des Modbus-Moduls ein Modul für die aktuelle Generation der Pluggit Avent Lüftungsanlagen (AP190,AP310,AP460) mit Modbus TCP Schnittstelle über Ethernet geschrieben und
auch erfolgreich mit meiner AP310 in Betrieb genommen.
Vielen Dank an Stefan für das Modbus Basis Modul. Damit war die Einbindung wirklich schnell und einfach umzusetzen  ;D   
Das Modul möchte ich hiermit gerne Teilen und würde mich freuen wenn mal jemand mit mehr Modbus und Perl Erfahrung drüber schaut und mir Rückmeldung dazu gibt.
Bisher werden nur Betriebsinfos gelesen und der Modus und die Lüftergeschwindigkeit können gesetzt werden.

Gruß
Matthias

Reinerlein

Hallo Stefan,

danke schön schon mal...

Eine andere kleine Sache: Kannst du getList mit jeweils einem :noArg für die Readings zusammenbauen?
Momentan gibt es in der Fhemweb-Oberfläche neben der Get-Auswahl immer noch ein Eingabefeld, welches den aktuellen Wert enthält.
Wenn man jetzt den Wert dort drin läßt, und auf den Button get drückt, gibt es eine Fehlermeldung... Man muss das Feld erst leermachen...

Grüße
Reiner

StefanStrobel

Hallo Reiner,

Ich nehm es auf die Liste für die nächste Version.

Gruß
    Stefan

mkunst

Da es keinen bösen Aufschrei zu meinem Pluggit Modul gab, hab ich für die weitere Entwicklung einen eigenen Thread erstellt  ;) :
https://forum.fhem.de/index.php/topic,51437.msg430943.html#msg430943
Dort gibts auch eine neue erweiterte Version.
Gruß
Matthias

Herjemine

Hallo,

ich habe Probleme eine Modbus TCP Verbindung unter Windows aufzubauen.

Es kommt immer ein Fehler
Can't call method "status" on an undefined value at ./FHEM/98_Modbus.pm line 745
und perl stürzt ab

Da heist es ja
# This is relevant for windows/USB only
kann es sein dass der Modbus TCP Modus unter Windows nicht so recht mag, da er hier ja im USB Modus Unterwegs ist, der für TCP gar nicht gebraucht wird.

thx
Hermann

PS: mit QModMaster bekomm ich eine saubere Verbindung und Ergebnis über holding register

StefanStrobel

Hallo,

Ich habe leider kein Fhem unter Windows und muss mich da erst weiter reindenken.
Versuch doch mal die angehängte Version. Damit sollte zumindest nichts mehr abstürzen.

Die geänderte Funktion ist jetzt:


#####################################
sub
Modbus_Ready($)
{
  my ($hash) = @_;
  return DevIo_OpenDev($hash, 1, undef)
                if($hash->{STATE} eq "disconnected");

  # This is relevant for windows/USB only
  my $po = $hash->{USBDev};
  if ($po) {
    my ($BlockingFlags, $InBytes, $OutBytes, $ErrorFlags) = $po->status;
    return ($InBytes>0);
  }
}


Gruss
    Stefan


Herjemine

Hallo Stefan,

ja jetzt stürtzt nichts mehr ab, aber Daten kommen auch nicht
2016.03.28 18:50:28 5: CCGX: GetUpdate called
2016.03.28 18:50:28 5: CCGX: GetUpdate objects from attributes: h3
2016.03.28 18:50:28 5: CCGX: GetUpdate full object list: h3
2016.03.28 18:50:28 5: CCGX: GetUpdate check h3 => SpannungL1, poll = 0, last = 0
2016.03.28 18:50:28 5: CCGX: GetUpdate tries to combine read commands
2016.03.28 18:50:28 5: CCGX: GetUpdate called
2016.03.28 18:50:28 5: CCGX: GetUpdate objects from attributes: h3
2016.03.28 18:50:28 5: CCGX: GetUpdate full object list: h3
2016.03.28 18:50:28 5: CCGX: GetUpdate check h3 => SpannungL1, poll = 0, last = 0
2016.03.28 18:50:28 5: CCGX: GetUpdate tries to combine read commands
2016.03.28 18:50:59 5: CCGX: GetUpdate called
2016.03.28 18:50:59 5: CCGX: GetUpdate objects from attributes: h3
2016.03.28 18:50:59 5: CCGX: GetUpdate full object list: h3
2016.03.28 18:50:59 5: CCGX: GetUpdate check h3 => SpannungL1, poll = 0, last = 0
2016.03.28 18:50:59 5: CCGX: GetUpdate tries to combine read commands
2016.03.28 18:50:59 5: CCGX: GetUpdate called
2016.03.28 18:50:59 5: CCGX: GetUpdate objects from attributes: h3
2016.03.28 18:50:59 5: CCGX: GetUpdate full object list: h3
2016.03.28 18:50:59 5: CCGX: GetUpdate check h3 => SpannungL1, poll = 0, last = 0
2016.03.28 18:50:59 5: CCGX: GetUpdate tries to combine read commands


hab fürs erste ne ganz einfache konfig

define CCGX ModbusAttr 246 30 192.168.1.115:502 TCP
attr CCGX obj-h3-reading SpannungL1
attr CCGX verbose 5


von Adresse 246 Read Holding register 3
macht der Modbus Master schön  :)
oder hab ich da nen Denkfehler in der Config?

Ich denk wenn ich eine remote fhem auf meinem PI zum modbus lesen machen würde sollte es laufen ...

Thx Hermann

StefanStrobel

Hallo Hermann,

es fehlt mindestens noch ein Attribut, damit die Holding-Register auch per Default gepollt werden:

attr CCGX dev-h-defPoll 1


Dann sollte etwas mehr passieren.

Gruss
    Stefan

Herjemine

Hi Stefan,

ping das wars  ;D

so mag Dein Modbus auch mit Windoof  :)

thx
Hermann

Herjemine

Hallo Stefan,

ich schon wieder sorry  :-[

Ich bekomme jetzt immer wieder unplausible Readings/Logs
bei genauerer Analyse sind es Werte von anderen Adressen,
kann es sein, dass bei Fehlern oder Timeout die Werte die noch im Speicher sind übergeben werden?

Gruß Hermann

StefanStrobel

Hallo Hermann,

das könnte schon ein Bug im Modul sein.
Um den zu finden wäre es sehr hilfreich, wenn Du einen Auszug aus dem Log mit Verbose 5 für das Modul (Modbus) schicken könntest, wenn der Fehler auftritt ...

Gruss
   Stefan

Herjemine

Hallo Stefan,

hab jetzt wieder eins gefunden
falsche Werte sind

2016.04.05 22:56:31 4: BMV: ParseObj for SOC___ assigns 647.5
2016.04.05 22:57:34 4: BMV: ParseObj for Charged_Energy assigns 14.9
2016.04.05 22:57:34 4: BMV: ParseObj for Discharged_Energy assigns 393.7


der Wert 393.7 gehört eigentlich zu  Last_discharge
2016.04.05 22:56:31 4: BMV: ParseObj for Last_discharge assigns 393.7

und 647.5 gehört zu Discharged_Energy statt zu StateOfCharge das nicht mehr als 100% werden kann
2016.04.05 22:56:04 4: BMV: ParseObj for Discharged_Energy assigns 647.5

hier das Log dazu


2016.04.05 22:56:06 5: BMV: raw read: 004d00000005ee03020012
2016.04.05 22:56:06 5: BMV: ParseFrames got: 004d00000005ee03020012
2016.04.05 22:56:06 4: BMV: ParseFrames: fcode 3 from 238, tid 77, data 020012 expect 3 from 238, tid 77 for module BMV
2016.04.05 22:56:06 5: BMV: ParseObj called with 0012 and start 284
2016.04.05 22:56:06 5: BMV: ParseObj ObjInfo: reading=Charge_cycles, unpack=n, expr=, format=, map=
2016.04.05 22:56:06 4: BMV: ParseObj for Charge_cycles assigns 18
2016.04.05 22:56:06 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:06 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:06 4: BMV: handle queue sends 002a00000006ee03011b0001 (fcode 3 to 238 for Average_discharge, len 1)
2016.04.05 22:56:06 5: SW: 002a00000006ee03011b0001
2016.04.05 22:56:06 5: BMV: raw read: 002a00000005ee03020e6c
2016.04.05 22:56:06 5: BMV: ParseFrames got: 002a00000005ee03020e6c
2016.04.05 22:56:06 4: BMV: ParseFrames: fcode 3 from 238, tid 42, data 020e6c expect 3 from 238, tid 42 for module BMV
2016.04.05 22:56:06 5: BMV: ParseObj called with 0e6c and start 283
2016.04.05 22:56:06 5: BMV: ParseObj ObjInfo: reading=Average_discharge, unpack=n, expr=$val / -10, format=, map=
2016.04.05 22:56:06 5: BMV: ParseObj for Average_discharge evaluates 3692 with expr $val / -10
2016.04.05 22:56:06 4: BMV: ParseObj for Average_discharge assigns -369.2
2016.04.05 22:56:06 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:06 5: BMV: handle queue commDelay for device BMV not over, try again later
2016.04.05 22:56:07 4: BMV: handle queue sends 005100000006ee03011d0001 (fcode 3 to 238 for Fulldischarges, len 1)
2016.04.05 22:56:07 5: SW: 005100000006ee03011d0001
2016.04.05 22:56:07 5: BMV: raw read: 005100000005ee03020000
2016.04.05 22:56:07 5: BMV: ParseFrames got: 005100000005ee03020000
2016.04.05 22:56:07 4: BMV: ParseFrames: fcode 3 from 238, tid 81, data 020000 expect 3 from 238, tid 81 for module BMV
2016.04.05 22:56:07 5: BMV: ParseObj called with 0000 and start 285
2016.04.05 22:56:07 5: BMV: ParseObj ObjInfo: reading=Fulldischarges, unpack=n, expr=, format=, map=
2016.04.05 22:56:07 4: BMV: ParseObj for Fulldischarges assigns 0
2016.04.05 22:56:07 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:07 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:07 4: BMV: handle queue sends 003900000006ee0301050001 (fcode 3 to 238 for I_A_, len 1)
2016.04.05 22:56:07 5: SW: 003900000006ee0301050001
2016.04.05 22:56:07 5: BMV: raw read: 003900000005ee0302fed5
2016.04.05 22:56:07 5: BMV: ParseFrames got: 003900000005ee0302fed5
2016.04.05 22:56:07 4: BMV: ParseFrames: fcode 3 from 238, tid 57, data 02fed5 expect 3 from 238, tid 57 for module BMV
2016.04.05 22:56:07 5: BMV: ParseObj called with fed5 and start 261
2016.04.05 22:56:07 5: BMV: ParseObj ObjInfo: reading=I_A_, unpack=s>, expr=$val / 10, format=, map=
2016.04.05 22:56:07 5: BMV: ParseObj for I_A_ evaluates -299 with expr $val / 10
2016.04.05 22:56:07 4: BMV: ParseObj for I_A_ assigns -29.9
2016.04.05 22:56:07 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:07 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:08 4: BMV: handle queue sends 001900000006ee03012e0001 (fcode 3 to 238 for Charged_Energy, len 1)
2016.04.05 22:56:08 5: SW: 001900000006ee03012e0001
2016.04.05 22:56:08 5: BMV: raw read: 001900000005ee03021ef3
2016.04.05 22:56:08 5: BMV: ParseFrames got: 001900000005ee03021ef3
2016.04.05 22:56:08 4: BMV: ParseFrames: fcode 3 from 238, tid 25, data 021ef3 expect 3 from 238, tid 25 for module BMV
2016.04.05 22:56:08 5: BMV: ParseObj called with 1ef3 and start 302
2016.04.05 22:56:08 5: BMV: ParseObj ObjInfo: reading=Charged_Energy, unpack=n, expr=$val / 10, format=, map=
2016.04.05 22:56:08 5: BMV: ParseObj for Charged_Energy evaluates 7923 with expr $val / 10
2016.04.05 22:56:08 4: BMV: ParseObj for Charged_Energy assigns 792.3
2016.04.05 22:56:08 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:08 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:09 4: BMV: handle queue sends 002000000006ee0301030001 (fcode 3 to 238 for V_V_, len 1)
2016.04.05 22:56:09 5: SW: 002000000006ee0301030001
2016.04.05 22:56:09 5: BMV: raw read: 002000000005ee030209a1
2016.04.05 22:56:09 5: BMV: ParseFrames got: 002000000005ee030209a1
2016.04.05 22:56:09 4: BMV: ParseFrames: fcode 3 from 238, tid 32, data 0209a1 expect 3 from 238, tid 32 for module BMV
2016.04.05 22:56:09 5: BMV: ParseObj called with 09a1 and start 259
2016.04.05 22:56:09 5: BMV: ParseObj ObjInfo: reading=V_V_, unpack=n, expr=$val / 100, format=, map=
2016.04.05 22:56:09 5: BMV: ParseObj for V_V_ evaluates 2465 with expr $val / 100
2016.04.05 22:56:09 4: BMV: ParseObj for V_V_ assigns 24.65
2016.04.05 22:56:09 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:09 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:09 4: BMV: handle queue sends 005100000006ee0301210001 (fcode 3 to 238 for Time_since_last_full_charge, len 1)
2016.04.05 22:56:09 5: SW: 005100000006ee0301210001
2016.04.05 22:56:09 5: BMV: raw read: 005100000005ee03020ae0
2016.04.05 22:56:09 5: BMV: ParseFrames got: 005100000005ee03020ae0
2016.04.05 22:56:09 4: BMV: ParseFrames: fcode 3 from 238, tid 81, data 020ae0 expect 3 from 238, tid 81 for module BMV
2016.04.05 22:56:09 5: BMV: ParseObj called with 0ae0 and start 289
2016.04.05 22:56:09 5: BMV: ParseObj ObjInfo: reading=Time_since_last_full_charge, unpack=n, expr=$val / 1000, format=, map=
2016.04.05 22:56:09 5: BMV: ParseObj for Time_since_last_full_charge evaluates 2784 with expr $val / 1000
2016.04.05 22:56:09 4: BMV: ParseObj for Time_since_last_full_charge assigns 2.784
2016.04.05 22:56:09 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:09 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:10 4: BMV: handle queue sends 00c500000006ee03011e0001 (fcode 3 to 238 for Total_Ah_drawn, len 1)
2016.04.05 22:56:10 5: SW: 00c500000006ee03011e0001
2016.04.05 22:56:10 5: BMV: raw read: 00c500000005ee03021940
2016.04.05 22:56:10 5: BMV: ParseFrames got: 00c500000005ee03021940
2016.04.05 22:56:10 4: BMV: ParseFrames: fcode 3 from 238, tid 197, data 021940 expect 3 from 238, tid 197 for module BMV
2016.04.05 22:56:10 5: BMV: ParseObj called with 1940 and start 286
2016.04.05 22:56:10 5: BMV: ParseObj ObjInfo: reading=Total_Ah_drawn, unpack=s>, expr=$val / 10, format=, map=
2016.04.05 22:56:10 5: BMV: ParseObj for Total_Ah_drawn evaluates 6464 with expr $val / 10
2016.04.05 22:56:10 4: BMV: ParseObj for Total_Ah_drawn assigns 646.4
2016.04.05 22:56:10 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:10 5: BMV: handle queue commDelay for device BMV not over, try again later
2016.04.05 22:56:10 4: BMV: handle queue sends 004600000006ee0301220001 (fcode 3 to 238 for Automatic_syncs, len 1)
2016.04.05 22:56:10 5: SW: 004600000006ee0301220001
2016.04.05 22:56:10 5: BMV: raw read: 004600000005ee03020021
2016.04.05 22:56:10 5: BMV: ParseFrames got: 004600000005ee03020021
2016.04.05 22:56:10 4: BMV: ParseFrames: fcode 3 from 238, tid 70, data 020021 expect 3 from 238, tid 70 for module BMV
2016.04.05 22:56:10 5: BMV: ParseObj called with 0021 and start 290
2016.04.05 22:56:10 5: BMV: ParseObj ObjInfo: reading=Automatic_syncs, unpack=n, expr=, format=, map=
2016.04.05 22:56:10 4: BMV: ParseObj for Automatic_syncs assigns 33
2016.04.05 22:56:10 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:10 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:10 4: BMV: handle queue sends 00c400000006ee03011b0001 (fcode 3 to 238 for Average_discharge, len 1)
2016.04.05 22:56:10 5: SW: 00c400000006ee03011b0001
2016.04.05 22:56:10 5: BMV: raw read: 00c400000005ee03020e6c
2016.04.05 22:56:10 5: BMV: ParseFrames got: 00c400000005ee03020e6c
2016.04.05 22:56:10 4: BMV: ParseFrames: fcode 3 from 238, tid 196, data 020e6c expect 3 from 238, tid 196 for module BMV
2016.04.05 22:56:10 5: BMV: ParseObj called with 0e6c and start 283
2016.04.05 22:56:10 5: BMV: ParseObj ObjInfo: reading=Average_discharge, unpack=n, expr=$val / -10, format=, map=
2016.04.05 22:56:10 5: BMV: ParseObj for Average_discharge evaluates 3692 with expr $val / -10
2016.04.05 22:56:10 4: BMV: ParseObj for Average_discharge assigns -369.2
2016.04.05 22:56:10 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:10 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:10 4: BMV: handle queue sends 00f300000006ee03011c0001 (fcode 3 to 238 for Charge_cycles, len 1)
2016.04.05 22:56:10 5: SW: 00f300000006ee03011c0001
2016.04.05 22:56:10 5: BMV: raw read: 00f300000005ee03020012
2016.04.05 22:56:10 5: BMV: ParseFrames got: 00f300000005ee03020012
2016.04.05 22:56:10 4: BMV: ParseFrames: fcode 3 from 238, tid 243, data 020012 expect 3 from 238, tid 243 for module BMV
2016.04.05 22:56:10 5: BMV: ParseObj called with 0012 and start 284
2016.04.05 22:56:10 5: BMV: ParseObj ObjInfo: reading=Charge_cycles, unpack=n, expr=, format=, map=
2016.04.05 22:56:10 4: BMV: ParseObj for Charge_cycles assigns 18
2016.04.05 22:56:11 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:11 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:11 4: BMV: handle queue sends 00e100000006ee0301090001 (fcode 3 to 238 for CE_Ah_, len 1)
2016.04.05 22:56:11 5: SW: 00e100000006ee0301090001
2016.04.05 22:56:11 5: BMV: raw read: 00e100000005ee03020705
2016.04.05 22:56:11 5: BMV: ParseFrames got: 00e100000005ee03020705
2016.04.05 22:56:11 4: BMV: ParseFrames: fcode 3 from 238, tid 225, data 020705 expect 3 from 238, tid 225 for module BMV
2016.04.05 22:56:11 5: BMV: ParseObj called with 0705 and start 265
2016.04.05 22:56:11 5: BMV: ParseObj ObjInfo: reading=CE_Ah_, unpack=n, expr=$val / -10, format=, map=
2016.04.05 22:56:11 5: BMV: ParseObj for CE_Ah_ evaluates 1797 with expr $val / -10
2016.04.05 22:56:11 4: BMV: ParseObj for CE_Ah_ assigns -179.7
2016.04.05 22:56:11 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:11 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:11 4: BMV: handle queue sends 00c400000006ee03011a0001 (fcode 3 to 238 for Last_discharge, len 1)
2016.04.05 22:56:11 5: SW: 00c400000006ee03011a0001
2016.04.05 22:56:11 5: BMV: raw read: 00c400000005ee03020f61
2016.04.05 22:56:11 5: BMV: ParseFrames got: 00c400000005ee03020f61
2016.04.05 22:56:11 4: BMV: ParseFrames: fcode 3 from 238, tid 196, data 020f61 expect 3 from 238, tid 196 for module BMV
2016.04.05 22:56:11 5: BMV: ParseObj called with 0f61 and start 282
2016.04.05 22:56:11 5: BMV: ParseObj ObjInfo: reading=Last_discharge, unpack=n, expr=$val / 10, format=, map=
2016.04.05 22:56:11 5: BMV: ParseObj for Last_discharge evaluates 3937 with expr $val / 10
2016.04.05 22:56:11 4: BMV: ParseObj for Last_discharge assigns 393.7
2016.04.05 22:56:11 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:11 5: BMV: handle queue commDelay for device BMV not over, try again later
2016.04.05 22:56:12 4: BMV: handle queue sends 003f00000006ee03010a0001 (fcode 3 to 238 for SOC___, len 1)
2016.04.05 22:56:12 5: SW: 003f00000006ee03010a0001
2016.04.05 22:56:14 5: BMV: raw read: 003f00000005ee0302036e
2016.04.05 22:56:14 5: BMV: ParseFrames got: 003f00000005ee0302036e
2016.04.05 22:56:14 4: BMV: ParseFrames: fcode 3 from 238, tid 63, data 02036e expect 3 from 238, tid 63 for module BMV
2016.04.05 22:56:14 5: BMV: ParseObj called with 036e and start 266
2016.04.05 22:56:14 5: BMV: ParseObj ObjInfo: reading=SOC___, unpack=n, expr=$val / 10, format=, map=
2016.04.05 22:56:14 5: BMV: ParseObj for SOC___ evaluates 878 with expr $val / 10
2016.04.05 22:56:14 4: BMV: ParseObj for SOC___ assigns 87.8
2016.04.05 22:56:14 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:14 5: BMV: handle queue commDelay for device BMV not over, try again later
2016.04.05 22:56:20 4: BMV: handle queue sends 006500000006ee03012d0001 (fcode 3 to 238 for Discharged_Energy, len 1)
2016.04.05 22:56:20 5: SW: 006500000006ee03012d0001
2016.04.05 22:56:21 5: BMV: raw read: 006500000005ee0302194b
2016.04.05 22:56:21 5: BMV: ParseFrames got: 006500000005ee0302194b
2016.04.05 22:56:21 4: BMV: ParseFrames: fcode 3 from 238, tid 101, data 02194b expect 3 from 238, tid 101 for module BMV
2016.04.05 22:56:21 5: BMV: ParseObj called with 194b and start 301
2016.04.05 22:56:21 5: BMV: ParseObj ObjInfo: reading=Discharged_Energy, unpack=n, expr=$val / 10, format=, map=
2016.04.05 22:56:21 5: BMV: ParseObj for Discharged_Energy evaluates 6475 with expr $val / 10
2016.04.05 22:56:21 4: BMV: ParseObj for Discharged_Energy assigns 647.5
2016.04.05 22:56:21 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:21 5: BMV: handle queue commDelay for device BMV not over, try again later
2016.04.05 22:56:25 4: BMV: handle queue sends 00c100000006ee03012d0001 (fcode 3 to 238 for Discharged_Energy, len 1)
2016.04.05 22:56:25 5: SW: 00c100000006ee03012d0001
2016.04.05 22:56:31 4: BMV: timeout waiting for 3 from 238, Request was 00c100000006ee03012d0001, last Buffer:
2016.04.05 22:56:31 4: BMV: handle queue sends 001000000006ee03010a0001 (fcode 3 to 238 for SOC___, len 1)
2016.04.05 22:56:31 5: SW: 001000000006ee03010a0001
2016.04.05 22:56:31 5: BMV: raw read: 00c100000005ee0302194b001000000005ee0302036e
2016.04.05 22:56:31 5: BMV: ParseFrames got: 00c100000005ee0302194b001000000005ee0302036e
2016.04.05 22:56:31 4: BMV: ParseFrames: fcode 3 from 238, tid 193, data 02194b001000000005ee0302036e expect 3 from 238, tid 16 for module BMV
2016.04.05 22:56:31 5: BMV: ParseObj called with 194b001000000005ee0302036e and start 266
2016.04.05 22:56:31 5: BMV: ParseObj ObjInfo: reading=SOC___, unpack=n, expr=$val / 10, format=, map=
2016.04.05 22:56:31 5: BMV: ParseObj for SOC___ evaluates 6475 with expr $val / 10
2016.04.05 22:56:31 4: BMV: ParseObj for SOC___ assigns 647.5
2016.04.05 22:56:31 5: BMV: ParseObj moves to next object, skip 1 to 267
2016.04.05 22:56:31 5: BMV: ParseObj has no parseInfo for h267
2016.04.05 22:56:31 5: BMV: ParseObj moves to next object, skip 1 to 268
2016.04.05 22:56:31 5: BMV: ParseObj has no parseInfo for h268
2016.04.05 22:56:31 5: BMV: ParseObj moves to next object, skip 1 to 269
2016.04.05 22:56:31 5: BMV: ParseObj has no parseInfo for h269
2016.04.05 22:56:31 5: BMV: ParseObj moves to next object, skip 1 to 270
2016.04.05 22:56:31 5: BMV: ParseObj has no parseInfo for h270
2016.04.05 22:56:31 5: BMV: ParseObj moves to next object, skip 1 to 271
2016.04.05 22:56:31 5: BMV: ParseObj has no parseInfo for h271
2016.04.05 22:56:31 5: BMV: ParseObj moves to next object, skip 1 to 272
2016.04.05 22:56:31 5: BMV: ParseObj has no parseInfo for h272
2016.04.05 22:56:31 5: BMV: ParseObj has no parseInfo for h272
2016.04.05 22:56:31 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:31 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:31 4: BMV: handle queue sends 004d00000006ee03011a0001 (fcode 3 to 238 for Last_discharge, len 1)
2016.04.05 22:56:31 5: SW: 004d00000006ee03011a0001
2016.04.05 22:56:31 5: BMV: raw read: 004d00000005ee03020f61
2016.04.05 22:56:31 5: BMV: ParseFrames got: 004d00000005ee03020f61
2016.04.05 22:56:31 4: BMV: ParseFrames: fcode 3 from 238, tid 77, data 020f61 expect 3 from 238, tid 77 for module BMV
2016.04.05 22:56:31 5: BMV: ParseObj called with 0f61 and start 282
2016.04.05 22:56:31 5: BMV: ParseObj ObjInfo: reading=Last_discharge, unpack=n, expr=$val / 10, format=, map=
2016.04.05 22:56:31 5: BMV: ParseObj for Last_discharge evaluates 3937 with expr $val / 10
2016.04.05 22:56:31 4: BMV: ParseObj for Last_discharge assigns 393.7
2016.04.05 22:56:31 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:31 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:31 4: BMV: handle queue sends 004800000006ee0301090001 (fcode 3 to 238 for CE_Ah_, len 1)
2016.04.05 22:56:31 5: SW: 004800000006ee0301090001
2016.04.05 22:56:31 5: BMV: raw read: 004800000005ee03020707
2016.04.05 22:56:31 5: BMV: ParseFrames got: 004800000005ee03020707
2016.04.05 22:56:31 4: BMV: ParseFrames: fcode 3 from 238, tid 72, data 020707 expect 3 from 238, tid 72 for module BMV
2016.04.05 22:56:31 5: BMV: ParseObj called with 0707 and start 265
2016.04.05 22:56:31 5: BMV: ParseObj ObjInfo: reading=CE_Ah_, unpack=n, expr=$val / -10, format=, map=
2016.04.05 22:56:31 5: BMV: ParseObj for CE_Ah_ evaluates 1799 with expr $val / -10
2016.04.05 22:56:31 4: BMV: ParseObj for CE_Ah_ assigns -179.9
2016.04.05 22:56:31 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:31 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:31 4: BMV: handle queue sends 004500000006ee03011c0001 (fcode 3 to 238 for Charge_cycles, len 1)
2016.04.05 22:56:31 5: SW: 004500000006ee03011c0001
2016.04.05 22:56:31 5: BMV: raw read: 004500000005ee03020012
2016.04.05 22:56:31 5: BMV: ParseFrames got: 004500000005ee03020012
2016.04.05 22:56:31 4: BMV: ParseFrames: fcode 3 from 238, tid 69, data 020012 expect 3 from 238, tid 69 for module BMV
2016.04.05 22:56:31 5: BMV: ParseObj called with 0012 and start 284
2016.04.05 22:56:31 5: BMV: ParseObj ObjInfo: reading=Charge_cycles, unpack=n, expr=, format=, map=
2016.04.05 22:56:31 4: BMV: ParseObj for Charge_cycles assigns 18
2016.04.05 22:56:31 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:31 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:31 4: BMV: handle queue sends 00ef00000006ee03011b0001 (fcode 3 to 238 for Average_discharge, len 1)
2016.04.05 22:56:31 5: SW: 00ef00000006ee03011b0001
2016.04.05 22:56:31 5: BMV: raw read: 00ef00000005ee03020e6c
2016.04.05 22:56:31 5: BMV: ParseFrames got: 00ef00000005ee03020e6c
2016.04.05 22:56:31 4: BMV: ParseFrames: fcode 3 from 238, tid 239, data 020e6c expect 3 from 238, tid 239 for module BMV
2016.04.05 22:56:31 5: BMV: ParseObj called with 0e6c and start 283
2016.04.05 22:56:31 5: BMV: ParseObj ObjInfo: reading=Average_discharge, unpack=n, expr=$val / -10, format=, map=
2016.04.05 22:56:31 5: BMV: ParseObj for Average_discharge evaluates 3692 with expr $val / -10
2016.04.05 22:56:31 4: BMV: ParseObj for Average_discharge assigns -369.2
2016.04.05 22:56:32 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:32 5: BMV: handle queue sendDelay for device BMV not over, try again later
2016.04.05 22:56:32 4: BMV: handle queue sends 005700000006ee03011e0001 (fcode 3 to 238 for Total_Ah_drawn, len 1)
2016.04.05 22:56:32 5: SW: 005700000006ee03011e0001
2016.04.05 22:56:35 5: BMV: raw read: 005700000005ee03021941
2016.04.05 22:56:35 5: BMV: ParseFrames got: 005700000005ee03021941
2016.04.05 22:56:35 4: BMV: ParseFrames: fcode 3 from 238, tid 87, data 021941 expect 3 from 238, tid 87 for module BMV
2016.04.05 22:56:35 5: BMV: ParseObj called with 1941 and start 286
2016.04.05 22:56:35 5: BMV: ParseObj ObjInfo: reading=Total_Ah_drawn, unpack=s>, expr=$val / 10, format=, map=
2016.04.05 22:56:35 5: BMV: ParseObj for Total_Ah_drawn evaluates 6465 with expr $val / 10
2016.04.05 22:56:35 4: BMV: ParseObj for Total_Ah_drawn assigns 646.5
2016.04.05 22:56:35 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:35 5: BMV: handle queue commDelay for device BMV not over, try again later
2016.04.05 22:56:52 5: BMV: GetUpdate called
2016.04.05 22:56:52 5: BMV: GetUpdate objects from attributes: h284 h290 h285 h301 h283 h266 h259 h261 h302 h289 h286 h282 h265
2016.04.05 22:56:52 5: BMV: GetUpdate full object list: h259 h261 h265 h266 h282 h283 h284 h285 h286 h289 h290 h301 h302
2016.04.05 22:56:52 5: BMV: GetUpdate check h259 => V_V_, poll = 1, last = 1459889769.37936
2016.04.05 22:56:52 5: BMV: GetUpdate will request V_V_
2016.04.05 22:56:52 5: BMV: GetUpdate check h261 => I_A_, poll = 1, last = 1459889767.18185
2016.04.05 22:56:52 5: BMV: GetUpdate will request I_A_
2016.04.05 22:56:52 5: BMV: GetUpdate check h265 => CE_Ah_, poll = 1, last = 1459889791.67829
2016.04.05 22:56:52 5: BMV: GetUpdate will request CE_Ah_
2016.04.05 22:56:52 5: BMV: GetUpdate check h266 => SOC___, poll = 1, last = 1459889791.38093
2016.04.05 22:56:52 5: BMV: GetUpdate will request SOC___
2016.04.05 22:56:52 5: BMV: GetUpdate check h282 => Last_discharge, poll = 1, last = 1459889791.55677
2016.04.05 22:56:52 5: BMV: GetUpdate will request Last_discharge
2016.04.05 22:56:52 5: BMV: GetUpdate check h283 => Average_discharge, poll = 1, last = 1459889791.98954
2016.04.05 22:56:52 5: BMV: GetUpdate will request Average_discharge
2016.04.05 22:56:52 5: BMV: GetUpdate check h284 => Charge_cycles, poll = 1, last = 1459889791.81898
2016.04.05 22:56:52 5: BMV: GetUpdate will request Charge_cycles
2016.04.05 22:56:52 5: BMV: GetUpdate check h285 => Fulldischarges, poll = 1, last = 1459889767.02003
2016.04.05 22:56:52 5: BMV: GetUpdate will request Fulldischarges
2016.04.05 22:56:52 5: BMV: GetUpdate check h286 => Total_Ah_drawn, poll = 1, last = 1459889795.9088
2016.04.05 22:56:52 5: BMV: GetUpdate will request Total_Ah_drawn
2016.04.05 22:56:52 5: BMV: GetUpdate check h289 => Time_since_last_full_charge, poll = 1, last = 1459889769.54124
2016.04.05 22:56:52 5: BMV: GetUpdate will request Time_since_last_full_charge
2016.04.05 22:56:52 5: BMV: GetUpdate check h290 => Automatic_syncs, poll = 1, last = 1459889770.68535
2016.04.05 22:56:52 5: BMV: GetUpdate will request Automatic_syncs
2016.04.05 22:56:52 5: BMV: GetUpdate check h301 => Discharged_Energy, poll = 1, last = 1459889781.14737
2016.04.05 22:56:52 5: BMV: GetUpdate will request Discharged_Energy
2016.04.05 22:56:52 5: BMV: GetUpdate check h302 => Charged_Energy, poll = 1, last = 1459889768.0791
2016.04.05 22:56:52 5: BMV: GetUpdate will request Charged_Energy
2016.04.05 22:56:52 5: BMV: GetUpdate tries to combine read commands
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine V_V_ / h259 with I_A_ / h261, span would be 3
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine I_A_ / h261 with CE_Ah_ / h265, span would be 5
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine CE_Ah_ / h265 with SOC___ / h266, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine SOC___ / h266 with Last_discharge / h282, span would be 17
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Last_discharge / h282 with Average_discharge / h283, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Average_discharge / h283 with Charge_cycles / h284, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Charge_cycles / h284 with Fulldischarges / h285, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Fulldischarges / h285 with Total_Ah_drawn / h286, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Total_Ah_drawn / h286 with Time_since_last_full_charge / h289, span would be 4
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Time_since_last_full_charge / h289 with Automatic_syncs / h290, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Automatic_syncs / h290 with Discharged_Energy / h301, span would be 12
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Discharged_Energy / h301 with Charged_Energy / h302, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Automatic_syncs to queue: 008500000006ee0301220001 pdu 0301220001
2016.04.05 22:56:52 4: BMV: handle queue sends 008300000006ee0301220001 (fcode 3 to 238 for Automatic_syncs, len 1)
2016.04.05 22:56:52 5: SW: 008300000006ee0301220001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Total_Ah_drawn to queue: 00d000000006ee03011e0001 pdu 03011e0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for V_V_ to queue: 00f900000006ee0301030001 pdu 0301030001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Time_since_last_full_charge to queue: 00b200000006ee0301210001 pdu 0301210001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for I_A_ to queue: 006800000006ee0301050001 pdu 0301050001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Charged_Energy to queue: 00bb00000006ee03012e0001 pdu 03012e0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Fulldischarges to queue: 00ad00000006ee03011d0001 pdu 03011d0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Last_discharge to queue: 00be00000006ee03011a0001 pdu 03011a0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for SOC___ to queue: 006400000006ee03010a0001 pdu 03010a0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Discharged_Energy to queue: 00ba00000006ee03012d0001 pdu 03012d0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Charge_cycles to queue: 00f500000006ee03011c0001 pdu 03011c0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for CE_Ah_ to queue: 00da00000006ee0301090001 pdu 0301090001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Average_discharge to queue: 00e800000006ee03011b0001 pdu 03011b0001
2016.04.05 22:56:52 5: BMV: GetUpdate called
2016.04.05 22:56:52 5: BMV: GetUpdate objects from attributes: h284 h290 h285 h301 h283 h266 h259 h261 h302 h289 h286 h282 h265
2016.04.05 22:56:52 5: BMV: GetUpdate full object list: h259 h261 h265 h266 h282 h283 h284 h285 h286 h289 h290 h301 h302
2016.04.05 22:56:52 5: BMV: GetUpdate check h259 => V_V_, poll = 1, last = 1459889769.37936
2016.04.05 22:56:52 5: BMV: GetUpdate will request V_V_
2016.04.05 22:56:52 5: BMV: GetUpdate check h261 => I_A_, poll = 1, last = 1459889767.18185
2016.04.05 22:56:52 5: BMV: GetUpdate will request I_A_
2016.04.05 22:56:52 5: BMV: GetUpdate check h265 => CE_Ah_, poll = 1, last = 1459889791.67829
2016.04.05 22:56:52 5: BMV: GetUpdate will request CE_Ah_
2016.04.05 22:56:52 5: BMV: GetUpdate check h266 => SOC___, poll = 1, last = 1459889791.38093
2016.04.05 22:56:52 5: BMV: GetUpdate will request SOC___
2016.04.05 22:56:52 5: BMV: GetUpdate check h282 => Last_discharge, poll = 1, last = 1459889791.55677
2016.04.05 22:56:52 5: BMV: GetUpdate will request Last_discharge
2016.04.05 22:56:52 5: BMV: GetUpdate check h283 => Average_discharge, poll = 1, last = 1459889791.98954
2016.04.05 22:56:52 5: BMV: GetUpdate will request Average_discharge
2016.04.05 22:56:52 5: BMV: GetUpdate check h284 => Charge_cycles, poll = 1, last = 1459889791.81898
2016.04.05 22:56:52 5: BMV: GetUpdate will request Charge_cycles
2016.04.05 22:56:52 5: BMV: GetUpdate check h285 => Fulldischarges, poll = 1, last = 1459889767.02003
2016.04.05 22:56:52 5: BMV: GetUpdate will request Fulldischarges
2016.04.05 22:56:52 5: BMV: GetUpdate check h286 => Total_Ah_drawn, poll = 1, last = 1459889795.9088
2016.04.05 22:56:52 5: BMV: GetUpdate will request Total_Ah_drawn
2016.04.05 22:56:52 5: BMV: GetUpdate check h289 => Time_since_last_full_charge, poll = 1, last = 1459889769.54124
2016.04.05 22:56:52 5: BMV: GetUpdate will request Time_since_last_full_charge
2016.04.05 22:56:52 5: BMV: GetUpdate check h290 => Automatic_syncs, poll = 1, last = 1459889770.68535
2016.04.05 22:56:52 5: BMV: GetUpdate will request Automatic_syncs
2016.04.05 22:56:52 5: BMV: GetUpdate check h301 => Discharged_Energy, poll = 1, last = 1459889781.14737
2016.04.05 22:56:52 5: BMV: GetUpdate will request Discharged_Energy
2016.04.05 22:56:52 5: BMV: GetUpdate check h302 => Charged_Energy, poll = 1, last = 1459889768.0791
2016.04.05 22:56:52 5: BMV: GetUpdate will request Charged_Energy
2016.04.05 22:56:52 5: BMV: GetUpdate tries to combine read commands
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine V_V_ / h259 with I_A_ / h261, span would be 3
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine I_A_ / h261 with CE_Ah_ / h265, span would be 5
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine CE_Ah_ / h265 with SOC___ / h266, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine SOC___ / h266 with Last_discharge / h282, span would be 17
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Last_discharge / h282 with Average_discharge / h283, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Average_discharge / h283 with Charge_cycles / h284, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Charge_cycles / h284 with Fulldischarges / h285, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Fulldischarges / h285 with Total_Ah_drawn / h286, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Total_Ah_drawn / h286 with Time_since_last_full_charge / h289, span would be 4
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Time_since_last_full_charge / h289 with Automatic_syncs / h290, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Automatic_syncs / h290 with Discharged_Energy / h301, span would be 12
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Discharged_Energy / h301 with Charged_Energy / h302, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Charge_cycles to queue: 007200000006ee03011c0001 pdu 03011c0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for CE_Ah_ to queue: 006f00000006ee0301090001 pdu 0301090001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Average_discharge to queue: 001000000006ee03011b0001 pdu 03011b0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Last_discharge to queue: 00c600000006ee03011a0001 pdu 03011a0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for SOC___ to queue: 004100000006ee03010a0001 pdu 03010a0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Discharged_Energy to queue: 003200000006ee03012d0001 pdu 03012d0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for I_A_ to queue: 000a00000006ee0301050001 pdu 0301050001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Charged_Energy to queue: 009300000006ee03012e0001 pdu 03012e0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Fulldischarges to queue: 001100000006ee03011d0001 pdu 03011d0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Total_Ah_drawn to queue: 00ed00000006ee03011e0001 pdu 03011e0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Automatic_syncs to queue: 00f100000006ee0301220001 pdu 0301220001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for V_V_ to queue: 00c200000006ee0301030001 pdu 0301030001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Time_since_last_full_charge to queue: 004200000006ee0301210001 pdu 0301210001
2016.04.05 22:56:52 5: BMV: GetUpdate called
2016.04.05 22:56:52 5: BMV: GetUpdate objects from attributes: h284 h290 h285 h301 h283 h266 h259 h261 h302 h289 h286 h282 h265
2016.04.05 22:56:52 5: BMV: GetUpdate full object list: h259 h261 h265 h266 h282 h283 h284 h285 h286 h289 h290 h301 h302
2016.04.05 22:56:52 5: BMV: GetUpdate check h259 => V_V_, poll = 1, last = 1459889769.37936
2016.04.05 22:56:52 5: BMV: GetUpdate will request V_V_
2016.04.05 22:56:52 5: BMV: GetUpdate check h261 => I_A_, poll = 1, last = 1459889767.18185
2016.04.05 22:56:52 5: BMV: GetUpdate will request I_A_
2016.04.05 22:56:52 5: BMV: GetUpdate check h265 => CE_Ah_, poll = 1, last = 1459889791.67829
2016.04.05 22:56:52 5: BMV: GetUpdate will request CE_Ah_
2016.04.05 22:56:52 5: BMV: GetUpdate check h266 => SOC___, poll = 1, last = 1459889791.38093
2016.04.05 22:56:52 5: BMV: GetUpdate will request SOC___
2016.04.05 22:56:52 5: BMV: GetUpdate check h282 => Last_discharge, poll = 1, last = 1459889791.55677
2016.04.05 22:56:52 5: BMV: GetUpdate will request Last_discharge
2016.04.05 22:56:52 5: BMV: GetUpdate check h283 => Average_discharge, poll = 1, last = 1459889791.98954
2016.04.05 22:56:52 5: BMV: GetUpdate will request Average_discharge
2016.04.05 22:56:52 5: BMV: GetUpdate check h284 => Charge_cycles, poll = 1, last = 1459889791.81898
2016.04.05 22:56:52 5: BMV: GetUpdate will request Charge_cycles
2016.04.05 22:56:52 5: BMV: GetUpdate check h285 => Fulldischarges, poll = 1, last = 1459889767.02003
2016.04.05 22:56:52 5: BMV: GetUpdate will request Fulldischarges
2016.04.05 22:56:52 5: BMV: GetUpdate check h286 => Total_Ah_drawn, poll = 1, last = 1459889795.9088
2016.04.05 22:56:52 5: BMV: GetUpdate will request Total_Ah_drawn
2016.04.05 22:56:52 5: BMV: GetUpdate check h289 => Time_since_last_full_charge, poll = 1, last = 1459889769.54124
2016.04.05 22:56:52 5: BMV: GetUpdate will request Time_since_last_full_charge
2016.04.05 22:56:52 5: BMV: GetUpdate check h290 => Automatic_syncs, poll = 1, last = 1459889770.68535
2016.04.05 22:56:52 5: BMV: GetUpdate will request Automatic_syncs
2016.04.05 22:56:52 5: BMV: GetUpdate check h301 => Discharged_Energy, poll = 1, last = 1459889781.14737
2016.04.05 22:56:52 5: BMV: GetUpdate will request Discharged_Energy
2016.04.05 22:56:52 5: BMV: GetUpdate check h302 => Charged_Energy, poll = 1, last = 1459889768.0791
2016.04.05 22:56:52 5: BMV: GetUpdate will request Charged_Energy
2016.04.05 22:56:52 5: BMV: GetUpdate tries to combine read commands
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine V_V_ / h259 with I_A_ / h261, span would be 3
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine I_A_ / h261 with CE_Ah_ / h265, span would be 5
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine CE_Ah_ / h265 with SOC___ / h266, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine SOC___ / h266 with Last_discharge / h282, span would be 17
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Last_discharge / h282 with Average_discharge / h283, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Average_discharge / h283 with Charge_cycles / h284, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Charge_cycles / h284 with Fulldischarges / h285, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Fulldischarges / h285 with Total_Ah_drawn / h286, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Total_Ah_drawn / h286 with Time_since_last_full_charge / h289, span would be 4
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Time_since_last_full_charge / h289 with Automatic_syncs / h290, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Automatic_syncs / h290 with Discharged_Energy / h301, span would be 12
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Discharged_Energy / h301 with Charged_Energy / h302, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Automatic_syncs to queue: 00d400000006ee0301220001 pdu 0301220001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Total_Ah_drawn to queue: 00b400000006ee03011e0001 pdu 03011e0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for V_V_ to queue: 006700000006ee0301030001 pdu 0301030001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Time_since_last_full_charge to queue: 007e00000006ee0301210001 pdu 0301210001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for I_A_ to queue: 00b700000006ee0301050001 pdu 0301050001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Charged_Energy to queue: 00ea00000006ee03012e0001 pdu 03012e0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Fulldischarges to queue: 002c00000006ee03011d0001 pdu 03011d0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for SOC___ to queue: 00f600000006ee03010a0001 pdu 03010a0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Last_discharge to queue: 00fd00000006ee03011a0001 pdu 03011a0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Discharged_Energy to queue: 00f700000006ee03012d0001 pdu 03012d0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Charge_cycles to queue: 008a00000006ee03011c0001 pdu 03011c0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for CE_Ah_ to queue: 00d600000006ee0301090001 pdu 0301090001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Average_discharge to queue: 00de00000006ee03011b0001 pdu 03011b0001
2016.04.05 22:56:52 5: BMV: GetUpdate called
2016.04.05 22:56:52 5: BMV: GetUpdate objects from attributes: h284 h290 h285 h301 h283 h266 h259 h261 h302 h289 h286 h282 h265
2016.04.05 22:56:52 5: BMV: GetUpdate full object list: h259 h261 h265 h266 h282 h283 h284 h285 h286 h289 h290 h301 h302
2016.04.05 22:56:52 5: BMV: GetUpdate check h259 => V_V_, poll = 1, last = 1459889769.37936
2016.04.05 22:56:52 5: BMV: GetUpdate will request V_V_
2016.04.05 22:56:52 5: BMV: GetUpdate check h261 => I_A_, poll = 1, last = 1459889767.18185
2016.04.05 22:56:52 5: BMV: GetUpdate will request I_A_
2016.04.05 22:56:52 5: BMV: GetUpdate check h265 => CE_Ah_, poll = 1, last = 1459889791.67829
2016.04.05 22:56:52 5: BMV: GetUpdate will request CE_Ah_
2016.04.05 22:56:52 5: BMV: GetUpdate check h266 => SOC___, poll = 1, last = 1459889791.38093
2016.04.05 22:56:52 5: BMV: GetUpdate will request SOC___
2016.04.05 22:56:52 5: BMV: GetUpdate check h282 => Last_discharge, poll = 1, last = 1459889791.55677
2016.04.05 22:56:52 5: BMV: GetUpdate will request Last_discharge
2016.04.05 22:56:52 5: BMV: GetUpdate check h283 => Average_discharge, poll = 1, last = 1459889791.98954
2016.04.05 22:56:52 5: BMV: GetUpdate will request Average_discharge
2016.04.05 22:56:52 5: BMV: GetUpdate check h284 => Charge_cycles, poll = 1, last = 1459889791.81898
2016.04.05 22:56:52 5: BMV: GetUpdate will request Charge_cycles
2016.04.05 22:56:52 5: BMV: GetUpdate check h285 => Fulldischarges, poll = 1, last = 1459889767.02003
2016.04.05 22:56:52 5: BMV: GetUpdate will request Fulldischarges
2016.04.05 22:56:52 5: BMV: GetUpdate check h286 => Total_Ah_drawn, poll = 1, last = 1459889795.9088
2016.04.05 22:56:52 5: BMV: GetUpdate will request Total_Ah_drawn
2016.04.05 22:56:52 5: BMV: GetUpdate check h289 => Time_since_last_full_charge, poll = 1, last = 1459889769.54124
2016.04.05 22:56:52 5: BMV: GetUpdate will request Time_since_last_full_charge
2016.04.05 22:56:52 5: BMV: GetUpdate check h290 => Automatic_syncs, poll = 1, last = 1459889770.68535
2016.04.05 22:56:52 5: BMV: GetUpdate will request Automatic_syncs
2016.04.05 22:56:52 5: BMV: GetUpdate check h301 => Discharged_Energy, poll = 1, last = 1459889781.14737
2016.04.05 22:56:52 5: BMV: GetUpdate will request Discharged_Energy
2016.04.05 22:56:52 5: BMV: GetUpdate check h302 => Charged_Energy, poll = 1, last = 1459889768.0791
2016.04.05 22:56:52 5: BMV: GetUpdate will request Charged_Energy
2016.04.05 22:56:52 5: BMV: GetUpdate tries to combine read commands
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine V_V_ / h259 with I_A_ / h261, span would be 3
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine I_A_ / h261 with CE_Ah_ / h265, span would be 5
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine CE_Ah_ / h265 with SOC___ / h266, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine SOC___ / h266 with Last_discharge / h282, span would be 17
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Last_discharge / h282 with Average_discharge / h283, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Average_discharge / h283 with Charge_cycles / h284, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Charge_cycles / h284 with Fulldischarges / h285, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Fulldischarges / h285 with Total_Ah_drawn / h286, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Total_Ah_drawn / h286 with Time_since_last_full_charge / h289, span would be 4
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Time_since_last_full_charge / h289 with Automatic_syncs / h290, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Automatic_syncs / h290 with Discharged_Energy / h301, span would be 12
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: GetUpdate cannot combine Discharged_Energy / h301 with Charged_Energy / h302, span would be 2
2016.04.05 22:56:52 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Charge_cycles to queue: 009400000006ee03011c0001 pdu 03011c0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for CE_Ah_ to queue: 00c800000006ee0301090001 pdu 0301090001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Average_discharge to queue: 006c00000006ee03011b0001 pdu 03011b0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for SOC___ to queue: 008500000006ee03010a0001 pdu 03010a0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Last_discharge to queue: 006f00000006ee03011a0001 pdu 03011a0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Discharged_Energy to queue: 00c500000006ee03012d0001 pdu 03012d0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for I_A_ to queue: 00e400000006ee0301050001 pdu 0301050001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Charged_Energy to queue: 008500000006ee03012e0001 pdu 03012e0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Fulldischarges to queue: 00fb00000006ee03011d0001 pdu 03011d0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Automatic_syncs to queue: 001e00000006ee0301220001 pdu 0301220001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Total_Ah_drawn to queue: 000500000006ee03011e0001 pdu 03011e0001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for V_V_ to queue: 005000000006ee0301030001 pdu 0301030001
2016.04.05 22:56:52 5: BMV: Send adds fcode 3 for Time_since_last_full_charge to queue: 002a00000006ee0301210001 pdu 0301210001
2016.04.05 22:56:56 5: BMV: raw read: 008300000005ee03020021
2016.04.05 22:56:56 5: BMV: ParseFrames got: 008300000005ee03020021
2016.04.05 22:56:56 4: BMV: ParseFrames: fcode 3 from 238, tid 131, data 020021 expect 3 from 238, tid 131 for module BMV
2016.04.05 22:56:56 5: BMV: ParseObj called with 0021 and start 290
2016.04.05 22:56:56 5: BMV: ParseObj ObjInfo: reading=Automatic_syncs, unpack=n, expr=, format=, map=
2016.04.05 22:56:56 4: BMV: ParseObj for Automatic_syncs assigns 33
2016.04.05 22:56:56 5: BMV: ParseFrames done, reply to fCode 3, 13 readings
2016.04.05 22:56:56 5: BMV: handle queue commDelay for device BMV not over, try again later
2016.04.05 22:57:04 5: BMV: GetUpdate called
2016.04.05 22:57:04 5: BMV: GetUpdate objects from attributes: h284 h290 h285 h301 h283 h266 h259 h261 h302 h289 h286 h282 h265
2016.04.05 22:57:04 5: BMV: GetUpdate full object list: h259 h261 h265 h266 h282 h283 h284 h285 h286 h289 h290 h301 h302
2016.04.05 22:57:04 5: BMV: GetUpdate check h259 => V_V_, poll = 1, last = 1459889769.37936
2016.04.05 22:57:04 5: BMV: GetUpdate will request V_V_
2016.04.05 22:57:04 5: BMV: GetUpdate check h261 => I_A_, poll = 1, last = 1459889767.18185
2016.04.05 22:57:04 5: BMV: GetUpdate will request I_A_
2016.04.05 22:57:04 5: BMV: GetUpdate check h265 => CE_Ah_, poll = 1, last = 1459889791.67829
2016.04.05 22:57:04 5: BMV: GetUpdate will request CE_Ah_
2016.04.05 22:57:04 5: BMV: GetUpdate check h266 => SOC___, poll = 1, last = 1459889791.38093
2016.04.05 22:57:04 5: BMV: GetUpdate will request SOC___
2016.04.05 22:57:04 5: BMV: GetUpdate check h282 => Last_discharge, poll = 1, last = 1459889791.55677
2016.04.05 22:57:04 5: BMV: GetUpdate will request Last_discharge
2016.04.05 22:57:04 5: BMV: GetUpdate check h283 => Average_discharge, poll = 1, last = 1459889791.98954
2016.04.05 22:57:04 5: BMV: GetUpdate will request Average_discharge
2016.04.05 22:57:04 5: BMV: GetUpdate check h284 => Charge_cycles, poll = 1, last = 1459889791.81898
2016.04.05 22:57:04 5: BMV: GetUpdate will request Charge_cycles
2016.04.05 22:57:04 5: BMV: GetUpdate check h285 => Fulldischarges, poll = 1, last = 1459889767.02003
2016.04.05 22:57:04 5: BMV: GetUpdate will request Fulldischarges
2016.04.05 22:57:04 5: BMV: GetUpdate check h286 => Total_Ah_drawn, poll = 1, last = 1459889795.9088
2016.04.05 22:57:04 5: BMV: GetUpdate will request Total_Ah_drawn
2016.04.05 22:57:04 5: BMV: GetUpdate check h289 => Time_since_last_full_charge, poll = 1, last = 1459889769.54124
2016.04.05 22:57:04 5: BMV: GetUpdate will request Time_since_last_full_charge
2016.04.05 22:57:04 5: BMV: GetUpdate check h290 => Automatic_syncs, poll = 1, last = 1459889816.5372
2016.04.05 22:57:04 5: BMV: GetUpdate will request Automatic_syncs
2016.04.05 22:57:04 5: BMV: GetUpdate check h301 => Discharged_Energy, poll = 1, last = 1459889781.14737
2016.04.05 22:57:04 5: BMV: GetUpdate will request Discharged_Energy
2016.04.05 22:57:04 5: BMV: GetUpdate check h302 => Charged_Energy, poll = 1, last = 1459889768.0791
2016.04.05 22:57:04 5: BMV: GetUpdate will request Charged_Energy
2016.04.05 22:57:04 5: BMV: GetUpdate tries to combine read commands
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine V_V_ / h259 with I_A_ / h261, span would be 3
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine I_A_ / h261 with CE_Ah_ / h265, span would be 5
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine CE_Ah_ / h265 with SOC___ / h266, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine SOC___ / h266 with Last_discharge / h282, span would be 17
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Last_discharge / h282 with Average_discharge / h283, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Average_discharge / h283 with Charge_cycles / h284, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Charge_cycles / h284 with Fulldischarges / h285, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Fulldischarges / h285 with Total_Ah_drawn / h286, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Total_Ah_drawn / h286 with Time_since_last_full_charge / h289, span would be 4
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Time_since_last_full_charge / h289 with Automatic_syncs / h290, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Automatic_syncs / h290 with Discharged_Energy / h301, span would be 12
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Discharged_Energy / h301 with Charged_Energy / h302, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Time_since_last_full_charge to queue: 00b800000006ee0301210001 pdu 0301210001
2016.04.05 22:57:04 4: BMV: handle queue sends 007b00000006ee0301210001 (fcode 3 to 238 for Time_since_last_full_charge, len 1)
2016.04.05 22:57:04 5: SW: 007b00000006ee0301210001
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for V_V_ to queue: 001d00000006ee0301030001 pdu 0301030001
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Automatic_syncs to queue: 002c00000006ee0301220001 pdu 0301220001
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Total_Ah_drawn to queue: 000b00000006ee03011e0001 pdu 03011e0001
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Fulldischarges to queue: 008400000006ee03011d0001 pdu 03011d0001
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Charged_Energy to queue: 00ad00000006ee03012e0001 pdu 03012e0001
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for I_A_ to queue: 006300000006ee0301050001 pdu 0301050001
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Discharged_Energy to queue: 005800000006ee03012d0001 pdu 03012d0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Last_discharge to queue: 00bd00000006ee03011a0001 pdu 03011a0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for SOC___ to queue: 00b600000006ee03010a0001 pdu 03010a0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Average_discharge to queue: 000100000006ee03011b0001 pdu 03011b0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for CE_Ah_ to queue: 00f100000006ee0301090001 pdu 0301090001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Charge_cycles to queue: 00df00000006ee03011c0001 pdu 03011c0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: GetUpdate called
2016.04.05 22:57:04 5: BMV: GetUpdate objects from attributes: h284 h290 h285 h301 h283 h266 h259 h261 h302 h289 h286 h282 h265
2016.04.05 22:57:04 5: BMV: GetUpdate full object list: h259 h261 h265 h266 h282 h283 h284 h285 h286 h289 h290 h301 h302
2016.04.05 22:57:04 5: BMV: GetUpdate check h259 => V_V_, poll = 1, last = 1459889769.37936
2016.04.05 22:57:04 5: BMV: GetUpdate will request V_V_
2016.04.05 22:57:04 5: BMV: GetUpdate check h261 => I_A_, poll = 1, last = 1459889767.18185
2016.04.05 22:57:04 5: BMV: GetUpdate will request I_A_
2016.04.05 22:57:04 5: BMV: GetUpdate check h265 => CE_Ah_, poll = 1, last = 1459889791.67829
2016.04.05 22:57:04 5: BMV: GetUpdate will request CE_Ah_
2016.04.05 22:57:04 5: BMV: GetUpdate check h266 => SOC___, poll = 1, last = 1459889791.38093
2016.04.05 22:57:04 5: BMV: GetUpdate will request SOC___
2016.04.05 22:57:04 5: BMV: GetUpdate check h282 => Last_discharge, poll = 1, last = 1459889791.55677
2016.04.05 22:57:04 5: BMV: GetUpdate will request Last_discharge
2016.04.05 22:57:04 5: BMV: GetUpdate check h283 => Average_discharge, poll = 1, last = 1459889791.98954
2016.04.05 22:57:04 5: BMV: GetUpdate will request Average_discharge
2016.04.05 22:57:04 5: BMV: GetUpdate check h284 => Charge_cycles, poll = 1, last = 1459889791.81898
2016.04.05 22:57:04 5: BMV: GetUpdate will request Charge_cycles
2016.04.05 22:57:04 5: BMV: GetUpdate check h285 => Fulldischarges, poll = 1, last = 1459889767.02003
2016.04.05 22:57:04 5: BMV: GetUpdate will request Fulldischarges
2016.04.05 22:57:04 5: BMV: GetUpdate check h286 => Total_Ah_drawn, poll = 1, last = 1459889795.9088
2016.04.05 22:57:04 5: BMV: GetUpdate will request Total_Ah_drawn
2016.04.05 22:57:04 5: BMV: GetUpdate check h289 => Time_since_last_full_charge, poll = 1, last = 1459889769.54124
2016.04.05 22:57:04 5: BMV: GetUpdate will request Time_since_last_full_charge
2016.04.05 22:57:04 5: BMV: GetUpdate check h290 => Automatic_syncs, poll = 1, last = 1459889816.5372
2016.04.05 22:57:04 5: BMV: GetUpdate will request Automatic_syncs
2016.04.05 22:57:04 5: BMV: GetUpdate check h301 => Discharged_Energy, poll = 1, last = 1459889781.14737
2016.04.05 22:57:04 5: BMV: GetUpdate will request Discharged_Energy
2016.04.05 22:57:04 5: BMV: GetUpdate check h302 => Charged_Energy, poll = 1, last = 1459889768.0791
2016.04.05 22:57:04 5: BMV: GetUpdate will request Charged_Energy
2016.04.05 22:57:04 5: BMV: GetUpdate tries to combine read commands
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine V_V_ / h259 with I_A_ / h261, span would be 3
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine I_A_ / h261 with CE_Ah_ / h265, span would be 5
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine CE_Ah_ / h265 with SOC___ / h266, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine SOC___ / h266 with Last_discharge / h282, span would be 17
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Last_discharge / h282 with Average_discharge / h283, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Average_discharge / h283 with Charge_cycles / h284, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Charge_cycles / h284 with Fulldischarges / h285, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Fulldischarges / h285 with Total_Ah_drawn / h286, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Total_Ah_drawn / h286 with Time_since_last_full_charge / h289, span would be 4
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Time_since_last_full_charge / h289 with Automatic_syncs / h290, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Automatic_syncs / h290 with Discharged_Energy / h301, span would be 12
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: GetUpdate cannot combine Discharged_Energy / h301 with Charged_Energy / h302, span would be 2
2016.04.05 22:57:04 5: BMV: GetUpdate: combine for h is 1
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Average_discharge to queue: 00b500000006ee03011b0001 pdu 03011b0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Charge_cycles to queue: 002300000006ee03011c0001 pdu 03011c0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for CE_Ah_ to queue: 002500000006ee0301090001 pdu 0301090001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Last_discharge to queue: 008600000006ee03011a0001 pdu 03011a0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for SOC___ to queue: 00e700000006ee03010a0001 pdu 03010a0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Discharged_Energy to queue: 007f00000006ee03012d0001 pdu 03012d0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Fulldischarges to queue: 001e00000006ee03011d0001 pdu 03011d0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for I_A_ to queue: 00bf00000006ee0301050001 pdu 0301050001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Charged_Energy to queue: 00d700000006ee03012e0001 pdu 03012e0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for V_V_ to queue: 00c200000006ee0301030001 pdu 0301030001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Time_since_last_full_charge to queue: 006b00000006ee0301210001 pdu 0301210001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Total_Ah_drawn to queue: 00b200000006ee03011e0001 pdu 03011e0001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: Send adds fcode 3 for Automatic_syncs to queue: 001f00000006ee0301220001 pdu 0301220001
2016.04.05 22:57:04 3: BMV: Send queue too long, dropping request
2016.04.05 22:57:04 5: BMV: GetUpdate called
2016.04.05 22:57:04 5: BMV: GetUpdate objects from attributes: h284 h290 h285 h301 h283 h266 h259 h261 h302 h289 h286 h282 h265
2016.04.05 22:57:04 5: BMV: GetUpdate full object list: h259 h261 h265 h266 h282 h283 h284 h285 h286 h289 h290 h301 h302
2016.04.05 22:57:04 5: BMV: GetUpdate check h259 => V_V_, poll = 1, last = 1459889769.37936
2016.04.05 22:57:04 5: BMV: GetUpdate will request V_V_
2016.04.05 22:57:04 5: BMV: GetUpdate check h261 => I_A_, poll = 1, last = 1459889767.18185
2016.04.05 22:57:04 5: BMV: GetUpdate will request I_A_
2016.04.05 22:57:04 5: BMV: GetUpdate check h265 => CE_Ah_, poll = 1, last = 1459889791.67829



ich hab das längere Log als File angehängt, war etwas groß für das Code Fenster.

Gruß
Hermann


StefanStrobel

#209
Hallo Hermann,

das Log war hilfreich. Es ist tatsächlich so, dass ein erster Request nicht rechtzeitig beantwortet wird. Das Modul meldet den Timeout und sendet dann den nächsten Request. Der Lesepuffer im Modul ist bis dahin noch leer. Beim nächsten Read kommt jedoch erst die Antwort auf den ersten Request an und die zweite Antwort hängt direkt dahinter. Das Modul hat bisher die verspätete erste Antwort als Antwort für den zweiten Request interpretiert, was natürlich falsch ist. Ein höherer Timeout sollte das Problem schon lösen.

Ich habe eine neue Version zum Testen angehängt. Die prüft jetzt eine Transaction Id und sollte das Problem ebenfalls beheben.

Da ich selbst kein Gerät mit Modbus-TCP habe sondern nur RTU, wäre es schön wenn ein paar Leute testen könnten, ob mit der Änderung noch alles funktioniert.

Gruss
   Stefan

EDIT 8.4.16: Angehängtes Modul entfernt, neuere Version in späterem Post.