HA ism7Mqtt Addon Orginal sowie experimental Version unamed_devices

Hallo alle,

Ich habe im Moment einige Probleme mit HA

das Addon ism7Mqtt bzw. auch die geforkte experimental Version produzieren bei jedem HA komplett Neustart neue Entitäts-IDs nach dem Muster Sensor.unnamed_device_xx.

Manchmal klappt dann die Anzeige der Werte im Dashboard und der History , und manchmal sind da Werten von ganz anderen Sensoren drin.

Ich hatte vor dem Addon die Wolfintegration am laufen und dort die Entitiy ids alle angepasst .

Nach dem Wechsel auf Ism7Mqtt habe ich die vom Addon erzeugten IDs auf die alten IDS geändert um die Historie aufrecht zu erhalten da ich hier Daten über mehrere Jahre gesammelt habe.

Die ersten Male hat das auch geklappt, und ich habe das System ohne Updates 2 Jahre laufen lassen da bei mir die Datenbankanpassung in irgendeiner 2022 oder 2023 Version immer scheiterte.

Seit dem Update auf die neuste Version habe ich nun das Problem mit den unamed_devices.

Nur noch einmal für mich zum Verständnis: Um was für eine Datenbankanpassung geht es da? Weil eine Datenbank gibt es eigentlich nur bei HA. Du wirst ja jetzt vermutlich nicht seit 2 oder 3 Jahren kein HA Update mehr gemacht haben, sondern das mit den 2 - 3 Jahren bezieht sich auf ein Update von ism7mqtt, oder? Oder meinst Du die Entitiy ID Anpassungen?

Damit ist dann HA 2025.11.2 gemeint oder die ism7mqtt Version


VG Jim

Doch habe länger keine Updates gehabt , da mein System lief.

Never touch … :slight_smile:

Das war das Upgrade eines Datenbank schemas.

entweder das oder 2023 da gab es auch ein ähnliches Problem

Hab dann Backup zurückgespielt und ohne Probleme HA am laufen gehabt.

HA ist die neuste Version.

Ism7Mqtt Experimental ist 10-06 und die orginale Version ist 017

Ups - seit 3 Jahren keine HA Updates ist natürlich heftig. :laughing: Aber da muss ich dann auch passen, weil sich in der Zeit so viel bei HA verändert hat das ich überhaupt nicht mehr nachvollziehen könnte wie damals mal irgendetwas wie aufgebaut, benannt usw. war und wie sich irgendwelche Entitäts- und/oder Entitäts-ID Umbenennungen von damals dann auf eine aktuelle HA-Version auswirken und warum dann jetzt bei jedem Neustart irgendwelche neuen Entitäts-IDs erstellt werden.

Aktuell ist der Aufbau und Ablauf ja so. Es gibt die /homeassistant/ism7-parameters-…json Datei und darin stehen die Bus-Adressen die ism7mqtt über das ISM7 ausgelesen hat. Die sieht dann ja so in der Art aus:

{
  "Devices": [
    {
      "ReadBusAddress": "0x00",
      "DeviceTemplateId": 190000,
      "Parameter": [
        190000,
        190001,
        190002,
        190003,
        190004,
        190007,
        190011,
        190012,
        190014,
        190015,
        190016,
        190019,
        190020,
        190021
      ]
    },
    {
      "ReadBusAddress": "0x8",
      "DeviceTemplateId": 180000,
      "Parameter": [
        180177,
usw.

Anhand der Parameter-Nr. wird dann ein Sensor (eine Entität) unter HA erstellt, in der sich dann auch immer die Parameter-Nr. wiederfindet.

Also z.B. für den Parameter mit der Warmwassertemperatur sieht die Bezeichnung dann so aus:

sensor.wolf_cgb2_0x03_180006_warmwassertemperatur

und die Parameter-Nr. aus der *.json ist die 180006.

Wenn ism7mqtt dann Entitäten mit so einer Bezeichnung erstellt

Sensor.unnamed_device_xx.

dann könnte es sein - eben weil dort unnamed_device steht, das er der Parameter-Nr. keine passende Bezeichnung zuordnen kann. Oder alternativ, falls da bei Dir statt den xx eine vorhandene Parameter-Nr. stehen sollte, das ihn Deine alten, umbenannten Entitäten “ins trudeln” bringen.

Aber ich habe leider absolut keine Idee wie Du das lösen, oder ggf. wieder geradebiegen könntest, außer natürlich ism7mqtt kompl. zu löschen und dann einen sauberen Neuanfang mit Neuinstallation damit zu machen. Dann wäre aber natürlich Deine ganze Historie weg. Man könnte dann zwar zumindest einzelne Summenwerte wieder manuell in die HA DB einpflegen, aber den Aufwand will sich wohl niemand freiwillig antun. :slightly_smiling_face:

Du könntest zwar noch mal bei zivillian

oder b3nn0

schauen, aber ich habe dort eben bei den Issues-Diskussionen einfach mal nach unnamed_device gesucht und das Ergebnis ist leider Null. D.h. so ein Problem ist dort scheinbar auch noch nicht diskutiert worden.

Fazit von mir: Ich muss da leider passen.

VG Jim

Ja da habe ich auch schon gesucht bzw. allgemein im Netz.

Ich werde nochmal schauen wie ich zwei Installationen von HA laufen lassen kann um besser zu testen.

Eventuell finde ich ja einen Weg die Daten in das neue System zu retten.

Das mit einer Testversion von HA wollte ich Dir auch schon vorschlagen. Ich habe hier auch mehrere HA VMs zum testen und herumspielen. :slightly_smiling_face:

Was das Daten übernehmen/retten anbelangt. Zu Fuß willst Du das ganz sicher nicht machen und dann 100 oder 200 Werte von irgendwelchen Wolf Entitäten einzeln einpflegen. Wenn wäre es auf Datenbankebene wohl sinnvoller. Die HA DB ist ja auch einfach nur SQL. Aber ob Du Dich damit wirklich in der Tiefe befassen willst, um dann exportierte Daten in die neue HA DB zu importieren, musst Du natürlich selber wissen. Auch wenn ich mich ein wenig eher allgemein mit SQL auskenne, aber mich dann auch noch mit der SQL-Datenstruktur der HA DB zu befassen wäre mir zu aufwändig. :laughing:

Die Frage ist ja auch was Du wirklich an historischen Wolf Daten brauchst, die Du dann unbedingt bei einem Neubeginn mit übernehmen willst. D.h. welche der vermutlich 200 + x an Wolf Entitäten sind Dir so wichtig das Du unbedingt wissen willst welchen Wert die mal von ein oder zwei Jahren hatten. Wenn ich mal bei mir schaue fallen mir die nicht viele historische Daten auf, auf die ich nicht verzichten kann oder könnte. Aber ok, ich bin nicht Du. Ich drücke Dir jedenfalls die Daumen das Du irgendeine Lösung findest. :slightly_smiling_face:

VG Jim

Danke :grinning_face:

Ich habe nur die für mich wichtigen Wolf Daten drin sprich 10-20 Sachen wie Vorlauf Rücklauf und ähnliches.

Die werde ich da schon rausbekommen, MySQL Workbench ist da ganz hilfreich.

Ich habe mal eine zweite HA Installion am laufen aber scheinbar kommt die sich zumindest bei einigen Sachen mit der Arbeitsversion in die Quere.

Der MQTT Explorer startet in der Testversion mit Fehler (ich glaube forbidden 40x), mal sehen wodran das liegt.

Das ISM7 Modul unterstützt immer nur eine Verbindung. D.h. wenn Du es bei Deiner HA Test Version laufen lässt muss es während dessen bei der anderen HA Version deaktiviert sein. Darum sollte man ja auch nicht, wenn man ism7mqtt nutzt, auf die Idee kommen dann auch noch mit der Wolf App oder Software auf das ISM7 zuzugreifen.

VG Jim

Ja das weiß ich, aber trotzdem danke.

Nach weiterer Suche habe ich den Auslöser gefunden.

Die alte Wolf-Integration war nur deaktiviert und unter Integrationen nicht zu sehen, auch die alten Entitäten wurde nicht angezeigt.

Da dort die Namen auch verwendet wurden hat HA wohl die unamed_Devices angelegt.

Ich muss mich hier mal einklinken, da ich das gleiche Problem habe. Ich habe gerade HA neu installiert und direkt die Experimental installiert. Leider bekomme auch ich nur Entitäten mit unnamed device.
Die alte HA-Installation läuft mit deaktivierten AddOns, damit ich die Geräte nach und nach neu installieren und einrichten kann. Kann das die Ursache sein?
Bzw. wie bekomme ich nun die alten Namen in die neue HA-Installation?

@Thomassh wie hast du das im Detail gelöst?

Edit: Ich habe eben die VM der alten HA-Installation ausgeschaltet, die MQTT-Geräte in der neuen Installation gelöscht, das AddOn deinstalliert (inkl. Löschen der Daten), die ism7-parameters-Wolf_Lüftungsanlage.json gelöscht, die neue VM neu gestartet, den ISM7 neu gestartet, das AddOn neu installiert, eingerichtet und gestartet → erneut heißen alle Entitäten unnamed_device

Hast du mal die Enititäts-id für eine Entität über den Button aktualisiert ?

Welchen Button meinst du? Den unter:
Geräte&Dienste - Entitäten - irgendeine Entität - Einstellungen ?

Ja, das hat nichts gebracht.

Ich habe auch versucht unter Geräte&Dienste - MQTT - Wolf irgendwas - drei Punkte oben rechts - Entitäts-ID neu erstellen was zu aktualisieren. Hier kam nur, das keine umbenennbaren Entitäts-ID’s vorhanden sind:

Moin

  1. Wie sieht der Inhalt Deiner ism7-parameters-…json aus, sprich sind dort die Sensoren über die Modbus-Adresse ausgelesen und mit Nr. gelistet? Bsp.:
{
  "Devices": [
    {
      "ReadBusAddress": "0x00",
      "DeviceTemplateId": 190000,
      "Parameter": [
        190000,
        190001,
        190002,
        190003,
        190004,
        190007,
        190011,
        190012,
        190014,
        190015,
        190016,
        190019,
        190020,
        190021
      ]
    },
    {
      "ReadBusAddress": "0x8",
      "DeviceTemplateId": 180000,
      "Parameter": [
        180177,
....
  1. Was steht im Protokoll des Ism7MQTT Experimental Addons?

  2. Um was für eine Wolf Lüftungsanlage geht es?

  3. Zwar eher etwas unwahrscheinlicher, aber was für eine Firmware-Version ist auf Deinem ISM7 installiert? Sollte darauf bereit die Version 5.x installiert sein funktioniert das ISM7 nicht mehr mit ism7mqtt.

  4. Ich habe zwar keine Ahnung ob das ggf. einen Einfluss hat, aber ich würde der Anlage bei dem ism7mqtt Addon auch einen anderen Gerätenamen geben - sprich dort


    und zwar einen ohne den Umlaut, damit das ü bei dem Dateinamen ism7-parameters-Wolf_Lüftungsanlage.json verschwindet. Eigentlich sollte das keinen Einfluss haben, aber bekanntlich hat man auch schon Pferde k… sehen. :laughing: Nach der Änderung am besten und sicherheitshalber noch einmal alles löschen und neu installieren.

VG Jim

@Jim_OS hier die gewünschten Infos:

  1. Die Sensoren wurden erkannt und richtig in die parameters-Liste eingetragen. Die Entitäten sehe ich auch in MQTT inkl. Werte. Auch Schalten funktioniert (z.B. von Automatik in reduzierte Lüftung, etc.)
    Hier die parameters…json:
ism7-parameters-Wolf-Lüftungsanlage

{
“TcpPort”: 9092,
“Devices”: [
{
“ReadBusAddress”: “0x00”,
“WriteBusAddress”: “0x00”,
“DeviceTemplateId”: 190000,
“Parameter”: [
190000,
190001,
190002,
190003,
190004,
190007,
190011,
190012,
190014,
190015,
190016,
190019,
190020,
190021
]
},
{
“ReadBusAddress”: “0x35”,
“WriteBusAddress”: “0x30”,
“DeviceTemplateId”: 220000,
“Parameter”: [
220001,
220021,
220022,
220023,
220025,
220026,
220027,
220028,
220029,
220030,
220031,
220032,
220033,
220037,
220038,
220039,
220040,
220041,
220043,
220044,
220045,
220046,
220091,
220095,
220103,
220104,
220107,
220108,
220117,
220126,
220129,
220130,
220134,
220135,
320378,
320379,
320380,
320381,
320382,
320383,
320384,
320385,
320386,
320387,
320388,
320389,
320390,
320391,
320392,
320393,
320394,
320395,
320396,
320397,
320398,
330012,
330013,
330014,
330015,
330016,
330017,
330018,
330019,
330020,
330021,
330022,
330023
]
},
{
“ReadBusAddress”: “0x3C”,
“WriteBusAddress”: “0x3C”,
“DeviceTemplateId”: 230000,
“Parameter”: [
230010,
230011,
230012,
230013,
230014,
230015,
230016,
230017,
230018,
230019,
230023,
230024,
230025,
230026,
230027,
230028,
230030,
230031,
230032,
230033,
230034,
230035,
230036,
230037,
230038,
230039,
230040,
230041,
230042,
230043,
230044,
230045,
230046,
230047,
230048,
230050,
230051,
230056,
230061,
230071,
230073
]
}
]
}

  1. Protokoll: Im Protokoll hat er nach der Installation sehr viel reingeschrieben. Für mich als Laien sieht es so aus, als ob er nur die Anlage ausgelesen hat und entsprechende Entitäten in die parameter…json geschrieben hat. Hier das Log-File:
Log-File nach Installation

s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service legacy-services: starting
s6-rc: info: service legacy-services successfully started
Using config from add-on configuration: 192.168.178.115/mqtt-user
Setting up ism7mqtt Wolf_Lüftungsanlage 192.168.178.201
Dec 30 11:20:51 Removing legacy retained topics for Wolf_Lüftungsanlage …
Creating initial configuration /config/ism7-parameters-Wolf_Lüftungsanlage.json
Dec 30 11:20:53 2025-12-30 11:20:53.8591|INFO|LuCon.WebPortal.StandaloneService.NetworkConnector|Try IP-resolve for host:192.168.178.201
Dec 30 11:20:53 2025-12-30 11:20:53.8884|INFO|LuCon.WebPortal.StandaloneService.NetworkConnector|Try connect destination server → 192.168.178.201:9092, Timeout:60000 ms
Dec 30 11:20:55 2025-12-30 11:20:55.2065|INFO|LuCon.SocketServer.SocketServerBase.GatewayContext|GW:-1,0 Written XML, bytes:118, msg:<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55 2025-12-30 11:20:55.3737|INFO|LuCon.WebPortal.StandaloneService.NetworkConnector|Got XML msg:<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:55
Dec 30 11:20:55 WolfLink
Dec 30 11:20:55

Dec 30 11:20:55 2025-12-30T11:20:47
Dec 30 11:20:55 300.10.1.300.300.1
Dec 30 11:20:55 3.0
Dec 30 11:20:55 WOLFLink
Dec 30 11:20:55
Dec 30 11:20:55 2025-12-30 11:20:55.3826|INFO|LuCon.WebPortal.StandaloneService.NetworkConnector|logonResponse:Errormsg:, State:ok
Dec 30 11:20:55 2025-12-30 11:20:55.4185|INFO|GW-1|GW:1,0 Written XML, bytes:81, msg:<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:55
Dec 30 11:20:55 2025-12-30 11:20:55.4651|TRACE|GW-1|GW:1,0 ReadTelegramAsync !!
Dec 30 11:20:55 2025-12-30 11:20:55.4671|TRACE|GW-1|GW:1,0 Got 6 bytes from stream, elapsedMs=1
Dec 30 11:20:55 2025-12-30 11:20:55.4671|TRACE|GW-1|GW:1,0 lenToRead: 440
Dec 30 11:20:55 2025-12-30 11:20:55.4684|TRACE|GW-1|GW:1,0 telegrType SystemconfigResponse
Dec 30 11:20:55 2025-12-30 11:20:55.4684|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:440 [6/440]
Dec 30 11:20:55 2025-12-30 11:20:55.5437|TRACE|GW-1|GW:1,0 Got 267 bytes from stream, elapsedMs=78
Dec 30 11:20:55 2025-12-30 11:20:55.5437|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:173 [273/440]
Dec 30 11:20:55 2025-12-30 11:20:55.5837|TRACE|GW-1|GW:1,0 Got 65 bytes from stream, elapsedMs=118
Dec 30 11:20:55 2025-12-30 11:20:55.5837|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:108 [338/440]
Dec 30 11:20:55 2025-12-30 11:20:55.6234|TRACE|GW-1|GW:1,0 Got 51 bytes from stream, elapsedMs=157
Dec 30 11:20:55 2025-12-30 11:20:55.6234|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:57 [389/440]
Dec 30 11:20:55 2025-12-30 11:20:55.6636|TRACE|GW-1|GW:1,0 Got 57 bytes from stream, elapsedMs=198
Dec 30 11:20:55 2025-12-30 11:20:55.6636|INFO|GW-1|GW:1,0 Got XML msg:???<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55 2025-12-30 11:20:55.6801|INFO|GW-1|GW:1,-1 - ProcessSystemconfigResponse:SystemconfigResponse, SID:1
Dec 30 11:20:55 2025-12-30 11:20:55.6921|INFO|GW-1|GW:1,-1 >>>>>>>>>>>> state:1, count:3{
Dec 30 11:20:55 {Device(-1), visible:True, ba:0x00, dt:GW, di:0 hdt:-1, sv:, sr:, wrsId:, HWSInd:-1, SYSHWSInd:-1, IsCombinedDevice:False, DeviceTemplateId:190000, ConfigIndex:0, ConfigMask:0}
Dec 30 11:20:55 {Device(-2), visible:False, ba:0x35, dt:BM, di:0 hdt:-1, sv:0x2, sr:0x4, wrsId:0x20, HWSInd:-1, SYSHWSInd:-1, IsCombinedDevice:False, DeviceTemplateId:220000, ConfigIndex:0, ConfigMask:49152}
Dec 30 11:20:55 {Device(-3), visible:False, ba:0x3C, dt:CWL, di:0 hdt:-1, sv:0xFF, sr:0xFF, wrsId:0x16, HWSInd:-1, SYSHWSInd:-1, IsCombinedDevice:False, DeviceTemplateId:230000, ConfigIndex:2, ConfigMask:802}}
Dec 30 11:20:55 <<<<<<<<<<<<
Dec 30 11:20:55 2025-12-30 11:20:55.7012|DEBUG|GW-1|#FirmwareUpdate - BundleQueueWorker - busyState:True
Dec 30 11:20:55 2025-12-30 11:20:55.7012|INFO|GW-1|executing task PullBundleAsync…
Dec 30 11:20:55 2025-12-30 11:20:55.7012|INFO|GW-1|RecurringPullBundle is now in suspend state
Dec 30 11:20:55 2025-12-30 11:20:55.7255|TRACE|GW-1|No push bundles to remove
Dec 30 11:20:55 2025-12-30 11:20:55.7267|TRACE|GW-1|write chunk:1, remaining cnt:0
Dec 30 11:20:55 2025-12-30 11:20:55.7543|INFO|GW-1|GW:1,0 Written XML, bytes:408, msg:<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:55
Dec 30 11:20:57 2025-12-30 11:20:57.0400|TRACE|GW-1|GW:1,0 ReadTelegramAsync !!
Dec 30 11:20:57 2025-12-30 11:20:57.0400|TRACE|GW-1|GW:1,0 Got 6 bytes from stream, elapsedMs=0
Dec 30 11:20:57 2025-12-30 11:20:57.0400|TRACE|GW-1|GW:1,0 lenToRead: 547
Dec 30 11:20:57 2025-12-30 11:20:57.0400|TRACE|GW-1|GW:1,0 telegrType TgrBundleResponse
Dec 30 11:20:57 2025-12-30 11:20:57.0400|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:547 [6/547]
Dec 30 11:20:57 2025-12-30 11:20:57.0795|TRACE|GW-1|GW:1,0 Got 103 bytes from stream, elapsedMs=39
Dec 30 11:20:57 2025-12-30 11:20:57.0795|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:444 [109/547]
Dec 30 11:20:57 2025-12-30 11:20:57.1200|TRACE|GW-1|GW:1,0 Got 62 bytes from stream, elapsedMs=79
Dec 30 11:20:57 2025-12-30 11:20:57.1200|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:382 [171/547]
Dec 30 11:20:57 2025-12-30 11:20:57.1594|TRACE|GW-1|GW:1,0 Got 62 bytes from stream, elapsedMs=119
Dec 30 11:20:57 2025-12-30 11:20:57.1594|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:320 [233/547]
Dec 30 11:20:57 2025-12-30 11:20:57.2000|TRACE|GW-1|GW:1,0 Got 63 bytes from stream, elapsedMs=159
Dec 30 11:20:57 2025-12-30 11:20:57.2000|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:257 [296/547]
Dec 30 11:20:57 2025-12-30 11:20:57.2400|TRACE|GW-1|GW:1,0 Got 62 bytes from stream, elapsedMs=199
Dec 30 11:20:57 2025-12-30 11:20:57.2400|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:195 [358/547]
Dec 30 11:20:57 2025-12-30 11:20:57.2800|TRACE|GW-1|GW:1,0 Got 63 bytes from stream, elapsedMs=239
Dec 30 11:20:57 2025-12-30 11:20:57.2800|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:132 [421/547]
Dec 30 11:20:57 2025-12-30 11:20:57.3200|TRACE|GW-1|GW:1,0 Got 62 bytes from stream, elapsedMs=279
Dec 30 11:20:57 2025-12-30 11:20:57.3200|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:70 [483/547]
Dec 30 11:20:57 2025-12-30 11:20:57.3602|TRACE|GW-1|GW:1,0 Got 62 bytes from stream, elapsedMs=320
Dec 30 11:20:57 2025-12-30 11:20:57.3602|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:8 [545/547]
Dec 30 11:20:57 2025-12-30 11:20:57.3994|TRACE|GW-1|GW:1,0 Got 8 bytes from stream, elapsedMs=359
Dec 30 11:20:57 2025-12-30 11:20:57.3994|INFO|GW-1|GW:1,0 Got XML msg:???<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57 2025-12-30 11:20:57.4157|DEBUG|GW-1|UpdateStoreValues[7] - Update value pid:22004300000 , ix:1 , in=“10163” , val:0 (null ), st:OK #1# Update value pid:22004600000 , ix:4 , in=“10165” , val:0 (null ), st:OK #1# Update value pid:22004500000 , ix:3 , in=“10185” , val:250 (null ), st:OK #1# Update value pid:22010800000 , ix:7 , in=“10130” , val:1 (null ), st:OK #1# Update value pid:22004400000 , ix:2 , in=“10162” , val:192 (null ), st:OK #1# Update value pid:22009100000 , ix:5 , in=“10920” , val:0 (null ), st:OK #1# Update value pid:22010700000 , ix:6 , in=“10812” , val:0 (null ), st:OK #1#
Dec 30 11:20:57 2025-12-30 11:20:57.4165|TRACE|GW-1|chunk id:1 commit success
Dec 30 11:20:57 2025-12-30 11:20:57.4165|TRACE|GW-1|bundle id:1 is complete after commit chunk
Dec 30 11:20:57 2025-12-30 11:20:57.4178|TRACE|GW-1|No push bundles to subscribe
Dec 30 11:20:57 2025-12-30 11:20:57.4186|INFO|GW-1|executing task PullBundleAsync completed
Dec 30 11:20:57 2025-12-30 11:20:57.4186|INFO|GW-1|RecurringPullBundle is now no longer in suspend state
Dec 30 11:20:57 2025-12-30 11:20:57.4200|INFO|GW-1|GW:1,-1 - UpdateBusconfigStep1
Dec 30 11:20:57 2025-12-30 11:20:57.4306|INFO|GW-1|GW:1,-1 >>>>>>>>>>>> state:1, count:3{
Dec 30 11:20:57 {Device(-1), visible:True, ba:0x00, dt:GW, di:0 hdt:-1, sv:, sr:, wrsId:, HWSInd:-1, SYSHWSInd:-1, IsCombinedDevice:False, DeviceTemplateId:190000, ConfigIndex:0, ConfigMask:0}
Dec 30 11:20:57 {Device(-2), visible:True, ba:0x35, dt:BM, di:0 hdt:-1, sv:0x2, sr:0x4, wrsId:0x20, HWSInd:-1, SYSHWSInd:-1, IsCombinedDevice:False, DeviceTemplateId:220000, ConfigIndex:0, ConfigMask:49152}
Dec 30 11:20:57 {Device(-3), visible:True, ba:0x3C, dt:CWL, di:0 hdt:-1, sv:0xFF, sr:0xFF, wrsId:0x16, HWSInd:-1, SYSHWSInd:-1, IsCombinedDevice:False, DeviceTemplateId:230000, ConfigIndex:2, ConfigMask:802}}
Dec 30 11:20:57 <<<<<<<<<<<<
Dec 30 11:20:57 2025-12-30 11:20:57.4314|INFO|GW-1|GW:1,-1 - UpdateBusconfigStep2
Dec 30 11:20:57 2025-12-30 11:20:57.4314|DEBUG|GW-1|#FirmwareUpdate - BundleQueueWorker - busyState:True
Dec 30 11:20:57 2025-12-30 11:20:57.4314|INFO|GW-1|executing task PullBundleAsync…
Dec 30 11:20:57 2025-12-30 11:20:57.4314|INFO|GW-1|RecurringPullBundle is now in suspend state
Dec 30 11:20:57 2025-12-30 11:20:57.4314|TRACE|GW-1|No push bundles to remove
Dec 30 11:20:57 2025-12-30 11:20:57.4314|TRACE|GW-1|write chunk:10, remaining cnt:0
Dec 30 11:20:57 2025-12-30 11:20:57.4326|DEBUG|GW-1|#FirmwareUpdate - BundleQueueWorker - busyState:True
Dec 30 11:20:57 2025-12-30 11:20:57.4332|INFO|GW-1|GW:1,0 Written XML, bytes:182, msg:<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57
Dec 30 11:20:57 2025-12-30 11:20:57.8801|TRACE|GW-1|GW:1,0 ReadTelegramAsync !!
Dec 30 11:20:57 2025-12-30 11:20:57.8801|TRACE|GW-1|GW:1,0 Got 6 bytes from stream, elapsedMs=0
Dec 30 11:20:57 2025-12-30 11:20:57.8801|TRACE|GW-1|GW:1,0 lenToRead: 234
Dec 30 11:20:57 2025-12-30 11:20:57.8801|TRACE|GW-1|GW:1,0 telegrType TgrBundleResponse
Dec 30 11:20:57 2025-12-30 11:20:57.8801|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:234 [6/234]
Dec 30 11:20:57 2025-12-30 11:20:57.9602|TRACE|GW-1|GW:1,0 Got 164 bytes from stream, elapsedMs=80
Dec 30 11:20:57 2025-12-30 11:20:57.9602|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:70 [170/234]
Dec 30 11:20:57 2025-12-30 11:20:57.9997|TRACE|GW-1|GW:1,0 Got 62 bytes from stream, elapsedMs=119
Dec 30 11:20:57 2025-12-30 11:20:57.9997|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:8 [232/234]
Dec 30 11:20:58 2025-12-30 11:20:58.0399|TRACE|GW-1|GW:1,0 Got 8 bytes from stream, elapsedMs=159
Dec 30 11:20:58 2025-12-30 11:20:58.0405|INFO|GW-1|GW:1,0 Got XML msg:???<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58 2025-12-30 11:20:58.0413|DEBUG|GW-1|UpdateStoreValues[2] - Update value pid:22010400000 , ix:8 , in=“618” , val:0 (null ), st:OK #1# Update value pid:22004000000 , ix:9 , in=“10180” , val:3 (null ), st:OK #1#
Dec 30 11:20:58 2025-12-30 11:20:58.0429|TRACE|GW-1|chunk id:10 commit success
Dec 30 11:20:58 2025-12-30 11:20:58.0429|TRACE|GW-1|bundle id:10 is complete after commit chunk
Dec 30 11:20:58 2025-12-30 11:20:58.0429|TRACE|GW-1|No push bundles to subscribe
Dec 30 11:20:58 2025-12-30 11:20:58.0429|INFO|GW-1|executing task PullBundleAsync completed
Dec 30 11:20:58 2025-12-30 11:20:58.0433|INFO|GW-1|RecurringPullBundle is now no longer in suspend state
Dec 30 11:20:58 2025-12-30 11:20:58.0447|INFO|GW-1|GW:1,-1 - FinishBusconfig
Dec 30 11:20:58 2025-12-30 11:20:58.0553|DEBUG|GW-1|GW:1,-1 BundleType:push, deviceVisibleReadAddresses:0x35,0x8B
Dec 30 11:20:58 2025-12-30 11:20:58.0553|INFO|GW-1|GW:1,0 Written XML, bytes:123, msg:<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58 2025-12-30 11:20:58.0613|DEBUG|GW-1|GW:1,-1 Detect SmartHome-System…
Dec 30 11:20:58 2025-12-30 11:20:58.0613|DEBUG|GW-1|GW:1,-1 SmartHome = 0
Dec 30 11:20:58 2025-12-30 11:20:58.0857|DEBUG|GW-1|Update existing busconfig parameter bundle type flags pid:22004000000, existing flags:None, new flags:SubscribeOnConnect
Dec 30 11:20:58 2025-12-30 11:20:58.0865|DEBUG|GW-1|Update existing busconfig parameter bundle type flags pid:22009100000, existing flags:None, new flags:RecurringPull
Dec 30 11:20:58 2025-12-30 11:20:58.0865|DEBUG|GW-1|Update existing busconfig parameter bundle type flags pid:22010400000, existing flags:None, new flags:RecurringPull
Dec 30 11:20:58 2025-12-30 11:20:58.0865|DEBUG|GW-1|Update existing busconfig parameter bundle type flags pid:22010800000, existing flags:None, new flags:RecurringPull
Dec 30 11:20:58 2025-12-30 11:20:58.0874|DEBUG|GW-1|Dump parameter mapping:PTID[220043] - MappingIndex: 1 #1# PTID[220044] - MappingIndex: 2 #1# PTID[220045] - MappingIndex: 3 #1# PTID[220046] - MappingIndex: 4 #1# PTID[220091] - MappingIndex: 5 #1# PTID[220107] - MappingIndex: 6 #1# PTID[220108] - MappingIndex: 7 #1# PTID[220104] - MappingIndex: 8 #1# PTID[220040] - MappingIndex: 9 #1# PTID[220129] - MappingIndex: 10 #1# PTID[220130] - MappingIndex: 12 #1# PTID[220135] - MappingIndex: 13 #1# PTID[220041] - MappingIndex: 15 #1# PTID[330012] - MappingIndex: 16 #1# PTID[330013] - MappingIndex: 17 #1# PTID[330014] - MappingIndex: 18 #1# PTID[330015] - MappingIndex: 19 #1# PTID[330016] - MappingIndex: 20 #1# PTID[330017] - MappingIndex: 21 #1# PTID[220037] - MappingIndex: 22 #1# PTID[330018] - MappingIndex: 23 #1# PTID[330019] - MappingIndex: 24 #1# PTID[330020] - MappingIndex: 25 #1# PTID[330021] - MappingIndex: 26 #1# PTID[330022] - MappingIndex: 27 #1# PTID[330023] - MappingIndex: 28 #1# PTID[220038] - MappingIndex: 29 #1# PTID[320378] - MappingIndex: 30 #1# PTID[320379] - MappingIndex: 31 #1# PTID[320380] - MappingIndex: 32 #1# PTID[320381] - MappingIndex: 33 #1# PTID[320382] - MappingIndex: 34 #1# PTID[320383] - MappingIndex: 35 #1# PTID[320384] - MappingIndex: 36 #1# PTID[320385] - MappingIndex: 37 #1# PTID[320386] - MappingIndex: 38 #1# PTID[320387] - MappingIndex: 39 #1# PTID[320388] - MappingIndex: 40 #1# PTID[320389] - MappingIndex: 41 #1# PTID[320390] - MappingIndex: 42 #1# PTID[320391] - MappingIndex: 43 #1# PTID[320392] - MappingIndex: 44 #1# PTID[320393] - MappingIndex: 45 #1# PTID[320394] - MappingIndex: 46 #1# PTID[320395] - MappingIndex: 47 #1# PTID[320396] - MappingIndex: 48 #1# PTID[320397] - MappingIndex: 49 #1# PTID[320398] - MappingIndex: 50 #1# PTID[220039] - MappingIndex: 51 #1# PTID[220001] - MappingIndex: 52 #1# PTID[220103] - MappingIndex: 53 #1# PTID[220032] - MappingIndex: 54 #1# PTID[220033] - MappingIndex: 55 #1# PTID[220134] - MappingIndex: 56 #1# PTID[220021] - MappingIndex: 58 #1# PTID[220022] - MappingIndex: 59 #1# PTID[220117] - MappingIndex: 60 #1# PTID[220023] - MappingIndex: 61 #1# PTID[220025] - MappingIndex: 63 #1# PTID[220026] - MappingIndex: 64 #1# PTID[220027] - MappingIndex: 65 #1# PTID[220028] - MappingIndex: 66 #1# PTID[220126] - MappingIndex: 67 #1# PTID[220029] - MappingIndex: 68 #1# PTID[220030] - MappingIndex: 69 #1# PTID[220031] - MappingIndex: 70 #1# PTID[220095] - MappingIndex: 72 #1# PTID[230050] - MappingIndex: 73 #1# PTID[230014] - MappingIndex: 74 #1# PTID[230010] - MappingIndex: 75 #1# PTID[230011] - MappingIndex: 76 #1# PTID[230015] - MappingIndex: 77 #1# PTID[230016] - MappingIndex: 78 #1# PTID[230017] - MappingIndex: 79 #1# PTID[230018] - MappingIndex: 80 #1# PTID[230071] - MappingIndex: 81 #1# PTID[230073] - MappingIndex: 82 #1# PTID[230012] - MappingIndex: 83 #1# PTID[230013] - MappingIndex: 84 #1# PTID[230019] - MappingIndex: 85 #1# PTID[230051] - MappingIndex: 86 #1# PTID[230056] - MappingIndex: 87 #1# PTID[230061] - MappingIndex: 88 #1# PTID[230023] - MappingIndex: 89 #1# PTID[230024] - MappingIndex: 90 #1# PTID[230025] - MappingIndex: 91 #1# PTID[230026] - MappingIndex: 92 #1# PTID[230027] - MappingIndex: 93 #1# PTID[230028] - MappingIndex: 94 #1# PTID[230030] - MappingIndex: 95 #1# PTID[230031] - MappingIndex: 96 #1# PTID[230032] - MappingIndex: 97 #1# PTID[230033] - MappingIndex: 98 #1# PTID[230034] - MappingIndex: 99 #1# PTID[230035] - MappingIndex: 100 #1# PTID[230036] - MappingIndex: 101 #1# PTID[230037] - MappingIndex: 102 #1# PTID[230038] - MappingIndex: 103 #1# PTID[230039] - MappingIndex: 104 #1# PTID[230040] - MappingIndex: 105 #1# PTID[230041] - MappingIndex: 106 #1# PTID[230042] - MappingIndex: 107 #1# PTID[230043] - MappingIndex: 108 #1# PTID[230044] - MappingIndex: 109 #1# PTID[230045] - MappingIndex: 110 #1# PTID[230046] - MappingIndex: 111 #1# PTID[230047] - MappingIndex: 112 #1# PTID[230048] - MappingIndex: 113 #1# PTID[190000] - MappingIndex: 114 #1# PTID[190001] - MappingIndex: 115 #1# PTID[190002] - MappingIndex: 116 #1# PTID[190003] - MappingIndex: 117 #1# PTID[190004] - MappingIndex: 118 #1# PTID[190007] - MappingIndex: 119 #1# PTID[190011] - MappingIndex: 120 #1# PTID[190012] - MappingIndex: 121 #1# PTID[190014] - MappingIndex: 122 #1# PTID[190015] - MappingIndex: 123 #1# PTID[190016] - MappingIndex: 124 #1# PTID[190019] - MappingIndex: 125 #1# PTID[190020] - MappingIndex: 126 #1# PTID[190021] - MappingIndex: 127 #1#
Dec 30 11:20:58 2025-12-30 11:20:58.0991|TRACE|GW-1|write chunk:1000, remaining cnt:1
Dec 30 11:20:58 2025-12-30 11:20:58.0997|INFO|GW-1|GW:1,0 Written XML, bytes:1078, msg:<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58
Dec 30 11:20:58 2025-12-30 11:20:58.0997|DEBUG|GW-1|#FirmwareUpdate - BundleQueueWorker - busyState:True
Dec 30 11:20:58 2025-12-30 11:20:58.9829|TRACE|GW-1|GW:1,0 ReadTelegramAsync !!
Dec 30 11:20:58 2025-12-30 11:20:58.9829|TRACE|GW-1|GW:1,0 Got 6 bytes from stream, elapsedMs=0
Dec 30 11:20:58 2025-12-30 11:20:58.9829|TRACE|GW-1|GW:1,0 lenToRead: 146
Dec 30 11:20:58 2025-12-30 11:20:58.9829|TRACE|GW-1|GW:1,0 telegrType TgrBundleResponse
Dec 30 11:20:58 2025-12-30 11:20:58.9829|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:146 [6/146]
Dec 30 11:20:59 2025-12-30 11:20:59.0262|TRACE|GW-1|GW:1,0 Got 146 bytes from stream, elapsedMs=43
Dec 30 11:20:59 2025-12-30 11:20:59.0262|INFO|GW-1|GW:1,0 Got XML msg:???<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:20:59
Dec 30 11:20:59
Dec 30 11:20:59
Dec 30 11:21:03 2025-12-30 11:21:03.6125|TRACE|GW-1|GW:1,0 ReadTelegramAsync !!
Dec 30 11:21:03 2025-12-30 11:21:03.6125|TRACE|GW-1|GW:1,0 Got 6 bytes from stream, elapsedMs=0
Dec 30 11:21:03 2025-12-30 11:21:03.6125|TRACE|GW-1|GW:1,0 lenToRead: 1452
Dec 30 11:21:03 2025-12-30 11:21:03.6125|TRACE|GW-1|GW:1,0 telegrType TgrBundleResponse
Dec 30 11:21:03 2025-12-30 11:21:03.6125|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:1452 [6/1452]
Dec 30 11:21:03 2025-12-30 11:21:03.6526|TRACE|GW-1|GW:1,0 Got 106 bytes from stream, elapsedMs=40
Dec 30 11:21:03 2025-12-30 11:21:03.6526|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:1346 [112/1452]
Dec 30 11:21:03 2025-12-30 11:21:03.6926|TRACE|GW-1|GW:1,0 Got 63 bytes from stream, elapsedMs=80
Dec 30 11:21:03 2025-12-30 11:21:03.6926|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:1283 [175/1452]
Dec 30 11:21:03 2025-12-30 11:21:03.7333|TRACE|GW-1|GW:1,0 Got 72 bytes from stream, elapsedMs=120
Dec 30 11:21:03 2025-12-30 11:21:03.7333|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:1211 [247/1452]
Dec 30 11:21:03 2025-12-30 11:21:03.7727|TRACE|GW-1|GW:1,0 Got 67 bytes from stream, elapsedMs=160
Dec 30 11:21:03 2025-12-30 11:21:03.7727|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:1144 [314/1452]
Dec 30 11:21:03 2025-12-30 11:21:03.8122|TRACE|GW-1|GW:1,0 Got 65 bytes from stream, elapsedMs=199
Dec 30 11:21:03 2025-12-30 11:21:03.8122|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:1079 [379/1452]
Dec 30 11:21:03 2025-12-30 11:21:03.8522|TRACE|GW-1|GW:1,0 Got 72 bytes from stream, elapsedMs=239
Dec 30 11:21:03 2025-12-30 11:21:03.8522|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:1007 [451/1452]
Dec 30 11:21:03 2025-12-30 11:21:03.8924|TRACE|GW-1|GW:1,0 Got 65 bytes from stream, elapsedMs=279
Dec 30 11:21:03 2025-12-30 11:21:03.8924|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:942 [516/1452]
Dec 30 11:21:03 2025-12-30 11:21:03.9324|TRACE|GW-1|GW:1,0 Got 62 bytes from stream, elapsedMs=319
Dec 30 11:21:03 2025-12-30 11:21:03.9324|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:880 [578/1452]
Dec 30 11:21:03 2025-12-30 11:21:03.9722|TRACE|GW-1|GW:1,0 Got 71 bytes from stream, elapsedMs=359
Dec 30 11:21:03 2025-12-30 11:21:03.9722|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:809 [649/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.0126|TRACE|GW-1|GW:1,0 Got 64 bytes from stream, elapsedMs=400
Dec 30 11:21:04 2025-12-30 11:21:04.0126|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:745 [713/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.0522|TRACE|GW-1|GW:1,0 Got 68 bytes from stream, elapsedMs=439
Dec 30 11:21:04 2025-12-30 11:21:04.0522|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:677 [781/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.0924|TRACE|GW-1|GW:1,0 Got 63 bytes from stream, elapsedMs=479
Dec 30 11:21:04 2025-12-30 11:21:04.0924|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:614 [844/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.1328|TRACE|GW-1|GW:1,0 Got 72 bytes from stream, elapsedMs=520
Dec 30 11:21:04 2025-12-30 11:21:04.1328|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:542 [916/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.1722|TRACE|GW-1|GW:1,0 Got 71 bytes from stream, elapsedMs=559
Dec 30 11:21:04 2025-12-30 11:21:04.1722|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:471 [987/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.2126|TRACE|GW-1|GW:1,0 Got 65 bytes from stream, elapsedMs=600
Dec 30 11:21:04 2025-12-30 11:21:04.2126|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:406 [1052/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.2527|TRACE|GW-1|GW:1,0 Got 73 bytes from stream, elapsedMs=640
Dec 30 11:21:04 2025-12-30 11:21:04.2527|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:333 [1125/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.2923|TRACE|GW-1|GW:1,0 Got 63 bytes from stream, elapsedMs=679
Dec 30 11:21:04 2025-12-30 11:21:04.2923|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:270 [1188/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.3323|TRACE|GW-1|GW:1,0 Got 71 bytes from stream, elapsedMs=719
Dec 30 11:21:04 2025-12-30 11:21:04.3323|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:199 [1259/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.3726|TRACE|GW-1|GW:1,0 Got 63 bytes from stream, elapsedMs=760
Dec 30 11:21:04 2025-12-30 11:21:04.3726|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:136 [1322/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.4122|TRACE|GW-1|GW:1,0 Got 65 bytes from stream, elapsedMs=799
Dec 30 11:21:04 2025-12-30 11:21:04.4122|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:71 [1387/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.4527|TRACE|GW-1|GW:1,0 Got 63 bytes from stream, elapsedMs=840
Dec 30 11:21:04 2025-12-30 11:21:04.4527|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:8 [1450/1452]
Dec 30 11:21:04 2025-12-30 11:21:04.4925|TRACE|GW-1|GW:1,0 Got 8 bytes from stream, elapsedMs=879
Dec 30 11:21:04 2025-12-30 11:21:04.4925|INFO|GW-1|GW:1,0 Got XML msg:???<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04 2025-12-30 11:21:04.4957|DEBUG|GW-1|UpdateStoreValues[25] - Update value pid:22003800000 , ix:29 , in=“10171” , val:0 (null ), st:OK #1# Update value pid:23001500000 , ix:77 , in=“12” , val:101 (null ), st:OK #1# Update value pid:33001600000 , ix:20 , in=“10161” , val:11:20 (null ), st:OK #1# Update value pid:33002200000 , ix:27 , in=“10161” , val:11:20 (null ), st:OK #1# Update value pid:22003200000 , ix:54 , in=“10161” , val:11:20 (null ), st:OK #1# Update value pid:33002100000 , ix:26 , in=“10175” , val:25.12.2025 (null ), st:OK #1# Update value pid:23001200000 , ix:83 , in=“20” , val:59 (null ), st:OK #1# Update value pid:33001300000 , ix:17 , in=“10168” , val:25.12.2025 (null ), st:OK #1# Update value pid:22004000000 , ix:9 , in=“10180” , val:3 (3 ), st:OK #1# Update value pid:23001700000 , ix:79 , in=“7” , val:18.1 (null ), st:OK #1# Update value pid:33001800000 , ix:23 , in=“10172” , val:14:30 (null ), st:OK #1# Update value pid:33001700000 , ix:21 , in=“10160” , val:30.12.2025 (null ), st:OK #1# Update value pid:33002300000 , ix:28 , in=“10160” , val:30.12.2025 (null ), st:OK #1# Update value pid:22003300000 , ix:55 , in=“10160” , val:30.12.2025 (null ), st:OK #1# Update value pid:22003700000 , ix:22 , in=“10166” , val:0 (null ), st:OK #1# Update value pid:23001400000 , ix:74 , in=“11” , val:99 (null ), st:OK #1# Update value pid:23007100000 , ix:81 , in=“15” , val:1 (null ), st:OK #1# Update value pid:33001500000 , ix:19 , in=“10170” , val:25.12.2025 (null ), st:OK #1# Update value pid:23005000000 , ix:73 , in=“1” , val:1 (null ), st:OK #1# Update value pid:23001600000 , ix:78 , in=“1” , val:1 (null ), st:OK #1# Update value pid:33002000000 , ix:25 , in=“10174” , val:13:13 (null ), st:OK #1# Update value pid:23001100000 , ix:76 , in=“22” , val:1 (null ), st:OK #1# Update value pid:22013500000 , ix:13 , in=“10127” , val:2 (null ), st:OK #1# Update value pid:33001200000 , ix:16 , in=“10167” , val:17:29 (null ), st:OK #1# Update value pid:22003900000 , ix:51 , in=“10178” , val:1 (null ), st:OK #1#
Dec 30 11:21:04 2025-12-30 11:21:04.4957|TRACE|GW-1|chunk id:1000 commit success
Dec 30 11:21:04 2025-12-30 11:21:04.4957|INFO|GW-1|GW:1,0 Written XML, bytes:449, msg:<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04
Dec 30 11:21:04 2025-12-30 11:21:04.4962|TRACE|GW-1|write chunk:1001, remaining cnt:0
Dec 30 11:21:05 2025-12-30 11:21:05.8530|TRACE|GW-1|GW:1,0 ReadTelegramAsync !!
Dec 30 11:21:05 2025-12-30 11:21:05.8530|TRACE|GW-1|GW:1,0 Got 6 bytes from stream, elapsedMs=0
Dec 30 11:21:05 2025-12-30 11:21:05.8530|TRACE|GW-1|GW:1,0 lenToRead: 591
Dec 30 11:21:05 2025-12-30 11:21:05.8530|TRACE|GW-1|GW:1,0 telegrType TgrBundleResponse
Dec 30 11:21:05 2025-12-30 11:21:05.8530|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:591 [6/591]
Dec 30 11:21:05 2025-12-30 11:21:05.9330|TRACE|GW-1|GW:1,0 Got 177 bytes from stream, elapsedMs=79
Dec 30 11:21:05 2025-12-30 11:21:05.9330|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:414 [183/591]
Dec 30 11:21:05 2025-12-30 11:21:05.9726|TRACE|GW-1|GW:1,0 Got 72 bytes from stream, elapsedMs=119
Dec 30 11:21:05 2025-12-30 11:21:05.9726|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:342 [255/591]
Dec 30 11:21:06 2025-12-30 11:21:06.0128|TRACE|GW-1|GW:1,0 Got 64 bytes from stream, elapsedMs=159
Dec 30 11:21:06 2025-12-30 11:21:06.0128|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:278 [319/591]
Dec 30 11:21:06 2025-12-30 11:21:06.0532|TRACE|GW-1|GW:1,0 Got 63 bytes from stream, elapsedMs=200
Dec 30 11:21:06 2025-12-30 11:21:06.0532|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:215 [382/591]
Dec 30 11:21:06 2025-12-30 11:21:06.0932|TRACE|GW-1|GW:1,0 Got 71 bytes from stream, elapsedMs=240
Dec 30 11:21:06 2025-12-30 11:21:06.0932|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:144 [453/591]
Dec 30 11:21:06 2025-12-30 11:21:06.1330|TRACE|GW-1|GW:1,0 Got 65 bytes from stream, elapsedMs=279
Dec 30 11:21:06 2025-12-30 11:21:06.1330|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:79 [518/591]
Dec 30 11:21:06 2025-12-30 11:21:06.1733|TRACE|GW-1|GW:1,0 Got 71 bytes from stream, elapsedMs=320
Dec 30 11:21:06 2025-12-30 11:21:06.1733|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:8 [589/591]
Dec 30 11:21:06 2025-12-30 11:21:06.2128|TRACE|GW-1|GW:1,0 Got 8 bytes from stream, elapsedMs=359
Dec 30 11:21:06 2025-12-30 11:21:06.2128|INFO|GW-1|GW:1,0 Got XML msg:???<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06 2025-12-30 11:21:06.2133|DEBUG|GW-1|UpdateStoreValues[7] - Update value pid:23007300000 , ix:82 , in=“41” , val:0 (null ), st:OK #1# Update value pid:23001300000 , ix:84 , in=“21” , val:40 (null ), st:OK #1# Update value pid:33001400000 , ix:18 , in=“10169” , val:14:29 (null ), st:OK #1# Update value pid:22004100000 , ix:15 , in=“10181” , val:1 (null ), st:OK #1# Update value pid:23001800000 , ix:80 , in=“8” , val:1.9 (null ), st:OK #1# Update value pid:33001900000 , ix:24 , in=“10173” , val:25.12.2025 (null ), st:OK #1# Update value pid:23001000000 , ix:75 , in=“14” , val:4 (null ), st:OK #1#
Dec 30 11:21:06 2025-12-30 11:21:06.2133|TRACE|GW-1|chunk id:1001 commit success
Dec 30 11:21:06 2025-12-30 11:21:06.2133|TRACE|GW-1|bundle id:1000 is complete after commit chunk
Dec 30 11:21:06 2025-12-30 11:21:06.2177|DEBUG|GW-1|FilterParametersWithIgnoreOnSubscriptionChange, bundleId:700, removed parameterIds:
Dec 30 11:21:06 2025-12-30 11:21:06.2188|DEBUG|GW-1|#FirmwareUpdate - BundleQueueWorker - busyState:True
Dec 30 11:21:06 2025-12-30 11:21:06.2188|INFO|GW-1|executing task ChangeSubscriptionBundlesAsync…
Dec 30 11:21:06 2025-12-30 11:21:06.2188|INFO|GW-1|RecurringPullBundle is now in suspend state
Dec 30 11:21:06 2025-12-30 11:21:06.2215|DEBUG|GW-1|ChangeSubscriptionBundlesAsync, session count:, bundleIdToAdd:700(22010400000,22003300000), bundleIdToRemove:()
Dec 30 11:21:06 2025-12-30 11:21:06.2215|INFO|GW-1|bundles before subscription change
Dec 30 11:21:06 2025-12-30 11:21:06.2240|INFO|GW-1|bundle:1000, state:Subscribed, chunks:2 (1000,1001), param ids:22003700000,22003800000,22003900000,22004000000,22004100000,22013500000,23001000000,23001100000,23001200000,23001300000,23001400000,23001500000,23001600000,23001700000,23001800000,23005000000,23007100000,23007300000,33001200000,33001300000,33001400000,33001500000,33001600000,33001700000,33001800000,33001900000,33002000000,33002100000,33002200000,33002300000, skipped param ids:, activated param ids:22003700000,22003800000,22003900000,22004000000,22004100000,22013500000,23001000000,23001100000,23001200000,23001300000,23001400000,23001500000,23001600000,23001700000,23001800000,23005000000,23007100000,23007300000,33001200000,33001300000,33001400000,33001500000,33001600000,33001700000,33001800000,33001900000,33002000000,33002100000,33002200000,33002300000
Dec 30 11:21:06 2025-12-30 11:21:06.2265|DEBUG|GW-1|parameter id:22003300000 ix:55 will not be subscribed, because parameter id:33002300000 ix:28 has same address and is already subscribed
Dec 30 11:21:06 2025-12-30 11:21:06.2265|DEBUG|GW-1|parameter id:22003300000 ix:55 will not be subscribed, because parameter id:33001700000 ix:21 has same address and is already subscribed
Dec 30 11:21:06 2025-12-30 11:21:06.2274|INFO|GW-1|Bundle:700, skipped pids (22003300000)
Dec 30 11:21:06 2025-12-30 11:21:06.2274|TRACE|GW-1|write chunk:700, remaining cnt:0
Dec 30 11:21:06 2025-12-30 11:21:06.2274|INFO|GW-1|GW:1,0 Written XML, bytes:138, msg:<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06
Dec 30 11:21:06 2025-12-30 11:21:06.2290|DEBUG|GW-1|#FirmwareUpdate - BundleQueueWorker - busyState:True
Dec 30 11:21:07 2025-12-30 11:21:07.4634|TRACE|GW-1|GW:1,0 ReadTelegramAsync !!
Dec 30 11:21:07 2025-12-30 11:21:07.4634|TRACE|GW-1|GW:1,0 Got 6 bytes from stream, elapsedMs=0
Dec 30 11:21:07 2025-12-30 11:21:07.4634|TRACE|GW-1|GW:1,0 lenToRead: 173
Dec 30 11:21:07 2025-12-30 11:21:07.4634|TRACE|GW-1|GW:1,0 telegrType TgrBundleResponse
Dec 30 11:21:07 2025-12-30 11:21:07.4634|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:173 [6/173]
Dec 30 11:21:07 2025-12-30 11:21:07.5435|TRACE|GW-1|GW:1,0 Got 165 bytes from stream, elapsedMs=80
Dec 30 11:21:07 2025-12-30 11:21:07.5435|TRACE|GW-1|GW:1,0 Try to complete msg, bytesMissing:8 [171/173]
Dec 30 11:21:07 2025-12-30 11:21:07.5835|TRACE|GW-1|GW:1,0 Got 8 bytes from stream, elapsedMs=120
Dec 30 11:21:07 2025-12-30 11:21:07.5843|INFO|GW-1|GW:1,0 Got XML msg:???<?xml version="1.0" encoding="utf-8"?>
Dec 30 11:21:07
Dec 30 11:21:07
Dec 30 11:21:07
Dec 30 11:21:07 2025-12-30 11:21:07.5843|DEBUG|GW-1|UpdateStoreValues[1] - Update value pid:22010400000 , ix:8 , in=“618” , val:0 (0 ), st:OK #1#
Dec 30 11:21:07 2025-12-30 11:21:07.5853|TRACE|GW-1|chunk id:700 commit success
Dec 30 11:21:07 2025-12-30 11:21:07.5853|TRACE|GW-1|bundle id:700 is complete after commit chunk
Dec 30 11:21:07 2025-12-30 11:21:07.5853|INFO|GW-1|bundles after subscription change
Dec 30 11:21:07 2025-12-30 11:21:07.5853|INFO|GW-1|bundle:1000, state:Subscribed, chunks:2 (1000,1001), param ids:22003700000,22003800000,22003900000,22004000000,22004100000,22013500000,23001000000,23001100000,23001200000,23001300000,23001400000,23001500000,23001600000,23001700000,23001800000,23005000000,23007100000,23007300000,33001200000,33001300000,33001400000,33001500000,33001600000,33001700000,33001800000,33001900000,33002000000,33002100000,33002200000,33002300000, skipped param ids:, activated param ids:22003700000,22003800000,22003900000,22004000000,22004100000,22013500000,23001000000,23001100000,23001200000,23001300000,23001400000,23001500000,23001600000,23001700000,23001800000,23005000000,23007100000,23007300000,33001200000,33001300000,33001400000,33001500000,33001600000,33001700000,33001800000,33001900000,33002000000,33002100000,33002200000,33002300000
Dec 30 11:21:07 2025-12-30 11:21:07.5853|INFO|GW-1|bundle:700, state:Subscribed, chunks:1 (700), param ids:22003300000,22010400000, skipped param ids:22003300000, activated param ids:22010400000
Dec 30 11:21:07 2025-12-30 11:21:07.5853|DEBUG|GW-1|#FirmwareUpdate - BundleQueueWorker - busyState:False
Dec 30 11:21:07 2025-12-30 11:21:07.5865|INFO|GW-1|executing task ChangeSubscriptionBundlesAsync completed
Dec 30 11:21:07 2025-12-30 11:21:07.5865|INFO|GW-1|RecurringPullBundle is now no longer in suspend state
Dec 30 11:21:07 2025-12-30 11:21:07.5865|INFO|GW-1|GW:1,-1 - FinishBusconfig, gw is online now
Dec 30 11:21:07 2025-12-30 11:21:07.5872|INFO|GW-1|GW:1,-1 >>>>>>>>>>>> state:1, count:3{
Dec 30 11:21:07 {Device(3), visible:True, ba:0x00, dt:GW, di:0 hdt:-1, sv:, sr:, wrsId:, HWSInd:-1, SYSHWSInd:-1, IsCombinedDevice:False, DeviceTemplateId:190000, ConfigIndex:0, ConfigMask:0}
Dec 30 11:21:07 {Device(4), visible:True, ba:0x35, dt:BM, di:0 hdt:-1, sv:0x2, sr:0x4, wrsId:0x20, HWSInd:-1, SYSHWSInd:-1, IsCombinedDevice:False, DeviceTemplateId:220000, ConfigIndex:0, ConfigMask:49152}
Dec 30 11:21:07 {Device(5), visible:True, ba:0x3C, dt:CWL, di:0 hdt:-1, sv:0xFF, sr:0xFF, wrsId:0x16, HWSInd:-1, SYSHWSInd:-1, IsCombinedDevice:False, DeviceTemplateId:230000, ConfigIndex:2, ConfigMask:802}}
Dec 30 11:21:07 <<<<<<<<<<<<
Dec 30 11:21:07 2025-12-30 11:21:07.5872|INFO|GW-1|DumpStore: param ix with same address:3,56 #1# param ix with same address:7,12 #1# param ix with same address:20,27,54 #1# param ix with same address:21,28,55 #1# param ix with same address:73,78 #1# param ix with same address:5,10 #1#
Dec 30 11:21:07 2025-12-30 11:21:07.5896|DEBUG|GW-1|DumpStore - values: did:3 id:19000000000 ix:114 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19000100000 ix:115 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19000200000 ix:116 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19000300000 ix:117 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19000400000 ix:118 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19000700000 ix:119 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19001100000 ix:120 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19001200000 ix:121 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19001400000 ix:122 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19001500000 ix:123 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19001600000 ix:124 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19001900000 ix:125 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19002000000 ix:126 exp:1 flags:0 type:0 st:0 val: ts: #1# did:3 id:19002100000 ix:127 exp:1 flags:0 type:0 st:0 val: ts: #1# did:4 id:22000100000 ix:52 in=“10121” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22002100000 ix:58 in=“271” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22002200000 ix:59 in=“388” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22002300000 ix:61 in=“257” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22002500000 ix:63 in=“35” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22002600000 ix:64 in=“701” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22002700000 ix:65 in=“702” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22002800000 ix:66 in=“408” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22002900000 ix:68 in=“41” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22003000000 ix:69 in=“42” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22003100000 ix:70 in=“10141” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22003200000 ix:54 in=“10161” exp:1 flags:2 type:0 st:1 val:11:20 ts:2025-12-30T10:21:04 #1# did:4 id:22003300000 ix:55 in=“10160” exp:1 flags:2 type:0 st:1 val:30.12.2025 ts:2025-12-30T10:21:04 #1# did:4 id:22003700000 ix:22 in=“10166” exp:0 flags:1 type:0 st:1 val:0 ts:2025-12-30T10:21:04 #1# did:4 id:22003800000 ix:29 in=“10171” exp:0 flags:1 type:0 st:1 val:0 ts:2025-12-30T10:21:04 #1# did:4 id:22003900000 ix:51 in=“10178” exp:0 flags:1 type:0 st:1 val:1 ts:2025-12-30T10:21:04 #1# did:4 id:22004000000 ix:9 in=“10180” exp:0 flags:1 type:2 st:1 val:3 ts:2025-12-30T10:21:04 #1# did:4 id:22004100000 ix:15 in=“10181” exp:0 flags:1 type:0 st:1 val:1 ts:2025-12-30T10:21:06 #1# did:4 id:22004300000 ix:1 in=“10163” exp:0 flags:0 type:1 st:1 val:0 ts:2025-12-30T10:20:57 #1# did:4 id:22004400000 ix:2 in=“10162” exp:0 flags:0 type:1 st:1 val:192 ts:2025-12-30T10:20:57 #1# did:4 id:22004500000 ix:3 in=“10185” exp:0 flags:0 type:1 st:1 val:250 ts:2025-12-30T10:20:57 #1# did:4 id:22004600000 ix:4 in=“10165” exp:0 flags:0 type:1 st:1 val:0 ts:2025-12-30T10:20:57 #1# did:4 id:22009100000 ix:5 in=“10920” exp:0 flags:2 type:1 st:1 val:0 ts:2025-12-30T10:20:57 #1# did:4 id:22009500000 ix:72 in=“10912” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22010300000 ix:53 in=“10195” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22010400000 ix:8 in=“618” exp:0 flags:2 type:2 st:1 val:0 ts:2025-12-30T10:21:07 #1# did:4 id:22010700000 ix:6 in=“10812” exp:0 flags:0 type:1 st:1 val:0 ts:2025-12-30T10:20:57 #1# did:4 id:22010800000 ix:7 in=“10130” exp:0 flags:2 type:1 st:1 val:1 ts:2025-12-30T10:20:57 #1# did:4 id:22011700000 ix:60 in=“265” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22012600000 ix:67 in=“1443” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22012900000 ix:10 in=“10920” exp:0 flags:0 type:0 st:0 val: ts: #1# did:4 id:22013000000 ix:12 in=“10130” exp:0 flags:0 type:0 st:0 val: ts: #1# did:4 id:22013400000 ix:56 in=“10185” exp:1 flags:2 type:0 st:0 val: ts: #1# did:4 id:22013500000 ix:13 in=“10127” exp:0 flags:1 type:0 st:1 val:2 ts:2025-12-30T10:21:04 #1# did:5 id:23001000000 ix:75 in=“14” exp:0 flags:1 type:0 st:1 val:4 ts:2025-12-30T10:21:06 #1# did:5 id:23001100000 ix:76 in=“22” exp:0 flags:1 type:0 st:1 val:1 ts:2025-12-30T10:21:04 #1# did:5 id:23001200000 ix:83 in=“20” exp:0 flags:1 type:0 st:1 val:59 ts:2025-12-30T10:21:04 #1# did:5 id:23001300000 ix:84 in=“21” exp:0 flags:1 type:0 st:1 val:40 ts:2025-12-30T10:21:06 #1# did:5 id:23001400000 ix:74 in=“11” exp:0 flags:1 type:0 st:1 val:99 ts:2025-12-30T10:21:04 #1# did:5 id:23001500000 ix:77 in=“12” exp:0 flags:1 type:0 st:1 val:101 ts:2025-12-30T10:21:04 #1# did:5 id:23001600000 ix:78 in=“1” exp:0 flags:1 type:0 st:1 val:1 ts:2025-12-30T10:21:04 #1# did:5 id:23001700000 ix:79 in=“7” exp:0 flags:1 type:0 st:1 val:18.1 ts:2025-12-30T10:21:04 #1# did:5 id:23001800000 ix:80 in=“8” exp:0 flags:1 type:0 st:1 val:1.9 ts:2025-12-30T10:21:06 #1# did:5 id:23001900000 ix:85 in=“33” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23002300000 ix:89 in=“4” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23002400000 ix:90 in=“48” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23002500000 ix:91 in=“27” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23002600000 ix:92 in=“7” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23002700000 ix:93 in=“8” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23002800000 ix:94 in=“9” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003000000 ix:95 in=“10” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003100000 ix:96 in=“11” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003200000 ix:97 in=“12” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003300000 ix:98 in=“13” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003400000 ix:99 in=“14” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003500000 ix:100 in=“15” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003600000 ix:101 in=“16” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003700000 ix:102 in=“17” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003800000 ix:103 in=“18” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23003900000 ix:104 in=“19” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23004000000 ix:105 in=“20” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23004100000 ix:106 in=“21” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23004200000 ix:107 in=“22” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23004300000 ix:108 in=“23” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23004400000 ix:109 in=“24” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23004500000 ix:110 in=“25” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23004600000 ix:111 in=“26” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23004700000 ix:112 in=“50” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23004800000 ix:113 in=“51” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23005000000 ix:73 in=“1” exp:0 flags:1 type:0 st:1 val:1 ts:2025-12-30T10:21:04 #1# did:5 id:23005100000 ix:86 in=“1” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23005600000 ix:87 in=“2” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23006100000 ix:88 in=“3” exp:1 flags:2 type:0 st:0 val: ts: #1# did:5 id:23007100000 ix:81 in=“15” exp:0 flags:1 type:0 st:1 val:1 ts:2025-12-30T10:21:04 #1# did:5 id:23007300000 ix:82 in=“41” exp:0 flags:1 type:0 st:1 val:0 ts:2025-12-30T10:21:06 #1# did:4 id:32037800000 ix:30 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32037900000 ix:31 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038000000 ix:32 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038100000 ix:33 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038200000 ix:34 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038300000 ix:35 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038400000 ix:36 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038500000 ix:37 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038600000 ix:38 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038700000 ix:39 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038800000 ix:40 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32038900000 ix:41 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32039000000 ix:42 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32039100000 ix:43 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32039200000 ix:44 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32039300000 ix:45 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32039400000 ix:46 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32039500000 ix:47 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32039600000 ix:48 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32039700000 ix:49 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:32039800000 ix:50 exp:0 flags:2 type:0 st:0 val: ts: #1# did:4 id:33001200000 ix:16 in=“10167” exp:0 flags:1 type:0 st:1 val:17:29 ts:2025-12-30T10:21:04 #1# did:4 id:33001300000 ix:17 in=“10168” exp:0 flags:1 type:0 st:1 val:25.12.2025 ts:2025-12-30T10:21:04 #1# did:4 id:33001400000 ix:18 in=“10169” exp:0 flags:1 type:0 st:1 val:14:29 ts:2025-12-30T10:21:06 #1# did:4 id:33001500000 ix:19 in=“10170” exp:0 flags:1 type:0 st:1 val:25.12.2025 ts:2025-12-30T10:21:04 #1# did:4 id:33001600000 ix:20 in=“10161” exp:0 flags:1 type:0 st:1 val:11:20 ts:2025-12-30T10:21:04 #1# did:4 id:33001700000 ix:21 in=“10160” exp:0 flags:1 type:0 st:1 val:30.12.2025 ts:2025-12-30T10:21:04 #1# did:4 id:33001800000 ix:23 in=“10172” exp:0 flags:1 type:0 st:1 val:14:30 ts:2025-12-30T10:21:04 #1# did:4 id:33001900000 ix:24 in=“10173” exp:0 flags:1 type:0 st:1 val:25.12.2025 ts:2025-12-30T10:21:06 #1# did:4 id:33002000000 ix:25 in=“10174” exp:0 flags:1 type:0 st:1 val:13:13 ts:2025-12-30T10:21:04 #1# did:4 id:33002100000 ix:26 in=“10175” exp:0 flags:1 type:0 st:1 val:25.12.2025 ts:2025-12-30T10:21:04 #1# did:4 id:33002200000 ix:27 in=“10161” exp:0 flags:1 type:0 st:1 val:11:20 ts:2025-12-30T10:21:04 #1# did:4 id:33002300000 ix:28 in=“10160” exp:0 flags:1 type:0 st:1 val:30.12.2025 ts:2025-12-30T10:21:04 #1#
Dec 30 11:21:07 2025-12-30 11:21:07.5905|DEBUG|GW-1|#FirmwareUpdate - BundleQueueWorker - busyState:False
Dec 30 11:21:08 Starting ism7mqtt --hass-id=Wolf_Lüftungsanlage --interval=60 --ipAddress=192.168.178.201 -t /config/ism7-parameters-Wolf_Lüftungsanlage.json

Was mir aber eben aufgefallen ist: Gestern Nachmittag hat er dann noch einige Einträge reingeschrieben bzgl. Connection reset by peer. Das kann aber auch gewesen sein, als ich den Zwischenstecker (Messung Stromaufnahme) neu starten musste, da ich ihn in meine Zigbee-Installation hinzugefügt habe. Hier die Log-Einträge:

Logeinträge wg. Connection reset by peer

Dec 30 15:45:22 System.Net.Sockets.SocketException (104): Connection reset by peer
Dec 30 15:45:22 at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Dec 30 15:45:22 at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Dec 30 15:45:22 at ism7ssl.Ism7SslStream.ReadAsync(Memory1 buffer, CancellationToken cancellationToken) Dec 30 15:45:22 at ism7mqtt.Ism7Client.FillPipeAsync(PipeWriter target, CancellationToken cancellationToken) in /app/ism7mqtt/ISM7/Ism7Client.cs:line 145 Dec 30 15:45:22 System.Net.Sockets.SocketException (104): Connection reset by peer Dec 30 15:45:22 at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken) Dec 30 15:45:22 at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token) Dec 30 15:45:22 at ism7ssl.Ism7SslStream.ReadAsync(Memory1 buffer, CancellationToken cancellationToken)
Dec 30 15:45:22 at ism7mqtt.Ism7Client.FillPipeAsync(PipeWriter target, CancellationToken cancellationToken) in /app/ism7mqtt/ISM7/Ism7Client.cs:line 145
Dec 30 15:45:22 at System.IO.Pipelines.Pipe.GetReadAsyncResult()
Dec 30 15:45:22 at ism7mqtt.Ism7Client.ReadPipeAsync(PipeReader source, CancellationToken cancellationToken)
Dec 30 15:45:32 Starting ism7mqtt --hass-id=Wolf_Lüftungsanlage --interval=60 --ipAddress=192.168.178.201 -t /config/ism7-parameters-Wolf_Lüftungsanlage.json
Dec 30 15:45:35 System.IO.InvalidDataException: invalid login state
Dec 30 15:45:35 at ism7mqtt.Ism7Client.OnAuthenticateAsync(IResponse response, CancellationToken cancellationToken) in /app/ism7mqtt/ISM7/Ism7Client.cs:line 323
Dec 30 15:45:35 at ism7mqtt.ResponseDispatcher.ResponseHandler.HandleAsync(IResponse response, CancellationToken cancellationToken) in /app/ism7mqtt/ISM7/ResponseDispatcher.cs:line 58
Dec 30 15:45:35 at ism7mqtt.ResponseDispatcher.DispatchAsync(IResponse response, CancellationToken cancellationToken) in /app/ism7mqtt/ISM7/ResponseDispatcher.cs:line 32
Dec 30 15:45:35 at ism7mqtt.Ism7Client.ReadPipeAsync(PipeReader source, CancellationToken cancellationToken) in /app/ism7mqtt/ISM7/Ism7Client.cs:line 191
Dec 30 15:45:45 Starting ism7mqtt --hass-id=Wolf_Lüftungsanlage --interval=60 --ipAddress=192.168.178.201 -t /config/ism7-parameters-Wolf_Lüftungsanlage.json

  1. Es handelt sich um eine CWL-300 Excellent. In meiner alten HA-Installation hat sich diese wunderbar integrieren lassen. Auch da bin ich am Schluss noch auf die Experimental gegangen, und alles hat weiterhin funktioniert

  2. Firmware: Wenn ich mit dem Browser die IP des ISM7 aufrufe, wird mir eine FW-Version 3.00 angezeigt.

  3. Den Namen habe ich mal geändert (Wolf-Lueftungsanlage) und anschließend HA neu gestartet. Laut AddOn-Log hat er alles nochmal ausgelesen und eine neue parameters…json erstellt (die alte habe ich gelöscht). Unter MQTT heißen die Entitäten leider weiterhin …unnamed_device_xx
    Auch ein Löschen der MQTT-Geräte und anschließendes “Neu aufbauen” im AddOn hat nichts gebracht.

Es ist zwar eine sch*** Arbeit, aber kann ich die Entitäten alle manuell umbenenen, ohne dass diese dann durch eine eventuelle Neu-Konfiguration in der Zukunft o.ä. sich zurück-umbennen oder so?

Was Deine letzte Frage betrifft kann ich dazu leider nichts sagen. War bei mir halt bisher noch nie notwendig und habe ich daher auch noch nie gemacht.

Wenn es vorher mit der alten HA Installation funktioniert hat dann dann muss es ja logischerweise irgendetwas mit Deiner neuen HA Installation zu tun haben. Die Frage ist “nur” was ist jetzt bei der neuen HA VM anders als bei der alten? :slightly_smiling_face:

Da werden sie Dir dann alle als durchnummerierte unnamed_device angezeigt und was genau ist “in MQTT”?

Ich habe hier meine Wolf Heizungsanlage per ism7mqtt und ISM7 bei HA eingebunden, daher mal die Screenshots davon. Wenn ich die HA MQTT Integration aufrufe werden mir darunter auch die Wolf Geräte angezeigt.


Wenn ich dann ein Wolf Gerät auswähle - hier Wolf CGB-2 - sieht es dann so aus

Da müssten dann bei Dir ja statt den tatsächlichen Sensoren Bezeichnungen nur die durchnummerierte unnamed_device als Name für die Steuerelemente und Sensor auftauchen, richtig?

Wenn Du per MQTT Explorer Dir die Topics von der Wolf Lüftungsanlage anzeigen lässt, werden dort die Topics mit dem korrekten Namen angezeigt? Bsp.

Was das Protokoll betrifft. So lässt sich das natürlich nur schwer lesen und irgendwie finde ich darin auch Einträge die m.M.n. nicht normal sind. Starte das Addon mal neu, warte dann mal z.B. 30 Minuten und poste dann das Protokoll ab dem Neustart hier noch einmal per
Forum_Code
Eigentlich sollte das Prorokoll (im besten Fall) dann nur so aussehen

s6-rc: info: service legacy-services: stopping
s6-rc: info: service legacy-services successfully stopped
s6-rc: info: service legacy-cont-init: stopping
s6-rc: info: service legacy-cont-init successfully stopped
s6-rc: info: service fix-attrs: stopping
s6-rc: info: service fix-attrs successfully stopped
s6-rc: info: service s6rc-oneshot-runner: stopping
s6-rc: info: service s6rc-oneshot-runner successfully stopped
s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service legacy-services: starting
s6-rc: info: service legacy-services successfully started
Reading config from MQTT broker add-on: core-mosquitto/addons
Setting up ism7mqtt Wolf 192.168.1.2
Dec 28 01:01:51 Removing legacy retained topics for Wolf ...
======= WARNING WARNING WARNING =======
Your parameter file /config/ism7-parameters-Wolf.json contains a lot of parameters!
If you encounter issues with disconnects or some parameters not being updated, read here:
https://github.com/b3nn0/hassio-addon-ism7mqtt?tab=readme-ov-file#important-if-some-entities-are-unavailable
======= WARNING WARNING WARNING =======
Dec 28 01:01:53 Starting ism7mqtt --hass-id=Wolf --interval=60 --ipAddress=192.168.1.2 -t /config/ism7-parameters-Wolf.json

Edit:

  1. Das mit dem ca. 30 Minuten warten ist halt dafür gedacht ob es dann in der eher kurzen Zeit schon/noch zu irgendwelchen Fehlermeldungen im Protokoll kommt.
  2. Das mit dem MQTT Explorer Test dürfte auch klar sein, sprich um zu klären ob bei dem MQTT Broker die Topics mit dem richtigen Namen ankommen, oder eben ggf. auch (schon) nicht. Weil ich halt nicht weiß was Du genau mit “in MQTT” meinst.

VG Jim

Unter Geräte&Dienste - MQTT sieht alles genau so aus wie bei dir:

Auch wenn ich in die Geräte selbst gehe, sieht alles noch so aus wie bei dir:

Wenn ich dann in eine Entität gehe, sieht auch alles normal aus:

Wenn ich dann aber oben rechts auf das Zahnrad klicke, sehe ich die Entitäts-ID als …unnamed_device_xx:

Und sorry - mit “in MQTT” Habe ich die Entitäts-ID gemeint. Das habe ich falsch beschrieben.

Im MQTT-Explorer wird alles richtig angezeigt:

Von daher vermute ich, dass die Entitäts-ID’s bei der Installation falsch vergeben wurden. Vermutlich, da ich hier dummerweise noch die alte HA-Installation mit aktiviertem AddOn laufen hatte. Die ist jetzt aber aus.

Restart vom AddOn mache ich gleich und ergänze ich in ca. 30-60 Minuten (ich muss nochmal kurz weg, dass passt dann).

Ja das vermute ich auch. Da müssen sich irgendwo noch irgendwelche Reste von der ersten Installation bei der neuen HA VM befinden. Wirf auch mal einen Blick unter Entwicklerwerkzeuge —> Statistik ob dort ggf. irgendwelche Wolf Sensoren zur Korrektur/Löschung angeboten werden.

Das Du nach dem löschen des Addons und der Neuinstalltion die HA VM erst neu gebootet und somit HA auch neu gestartet hattest, davon gehe ich jetzt mal als gegeben aus.

Anm.: Ich bin jetzt gleich auch erst einmal für eine Weile weg. :slightly_smiling_face:

Ach ja - da Du HA ja in einer VM laufen hast, könntest Du natürlich auch mal eben zum testen eine neue HA VM nur für das ism7mqtt Addon einrichten. Eine HA VM + MQTT Broker + ism7mqtt Addon + HA MQTT Integration ist ja eigentlich recht schnell erstellt. Dann hättest Du halt eine neue, “jungfräuliche” Version zu testen. :slightly_smiling_face:

VG JIm

“Connection reset by peer” kann kommen wenn zuviele Parameter freigeschaltet sind dann kann ein Timing Problem auftreten und die Wolf resetet die Verbindung. Dann dürften Daten (einige ?) auch nicht mehr aktualisiert werden

Ich schon wieder. :slightly_smiling_face:

Das kannst Du Dir sparen, denn das habe ich eben mal gemacht. :wink: Also das HA ism7mqtt Addon bei meiner Produktiv-HA-VM gestoppt und dann bei der Test-HA-VM das ism7mqtt Addon installiert. Und was soll ich sagen, ich bekomme dort jetzt auch alle Wolf Sensoren/Entitäten mit einer unnamed_device Bezeichnung. :rofl:

Ergo das ist also kein evtl. “Bug” oder Problem bei Dir, sondern da muss sich in den letzten paar Wochen/Monaten irgendetwas verändert haben. Ich vermute mal das das an irgendeinem HA Update liegt.

Ich muss/müsste jetzt selber erst ein wenig mehr “grübeln” was genau die Ursache dafür sein könnte, aber zumindest weißt Du jetzt schon mal das dieses Verhalten, bzw. die unnamed_device Bezeichnungen, aktuell scheinbar normal ist/sind. :slightly_smiling_face:

Edit: Das starten des ism7mqtt Addons bei der Test-HA-VM und das Protokoll, sehen auch vollkommen normal aus.

Dec 31 12:47:36 Starting ism7mqtt --hass-id=Wolf --interval=60 --ipAddress=192.168.1.2 -t /config/ism7-parameters-Wolf.json
s6-rc: info: service legacy-services: stopping
s6-rc: info: service legacy-services successfully stopped
s6-rc: info: service legacy-cont-init: stopping
s6-rc: info: service legacy-cont-init successfully stopped
s6-rc: info: service fix-attrs: stopping
s6-rc: info: service fix-attrs successfully stopped
s6-rc: info: service s6rc-oneshot-runner: stopping
s6-rc: info: service s6rc-oneshot-runner successfully stopped
s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service legacy-services: starting
s6-rc: info: service legacy-services successfully started
Reading config from MQTT broker add-on: core-mosquitto/addons
Setting up ism7mqtt Wolf 192.168.1.2
Dec 31 12:50:19 Removing legacy retained topics for Wolf ...
======= WARNING WARNING WARNING =======
Your parameter file /config/ism7-parameters-Wolf.json contains a lot of parameters!
If you encounter issues with disconnects or some parameters not being updated, read here:
https://github.com/b3nn0/hassio-addon-ism7mqtt?tab=readme-ov-file#important-if-some-entities-are-unavailable
======= WARNING WARNING WARNING =======
Dec 31 12:50:20 Starting ism7mqtt --hass-id=Wolf --interval=60 --ipAddress=192.168.1.2 -t /config/ism7-parameters-Wolf.json

VG Jim