NACK received. Popping from queue anyway

Ich vermute, dass es an der größeren Gerätezahl lag. Unzulässige Zeichen können eigentlich nicht sein.

Richtig. Ich habe das gerade nochmal geprüft, es sind nur die Verknüpfungen zwischen Wand- und Heizungsthermostaten die ich nicht (im Homematic Konfigurator) bearbeiten kann. Die Tür-/Fensterkontakte sind bearbeitbar.

@sathya, gibt es hierzu schon etwas Neues? Ich habe aktuell das Problem, dass das Wandthermostat häufig meint, dass ein Fenster geöffnet ist.

Ist es aber nicht, trotzdem geht die Solltemperatur auf 12° runter, das finde ich etwas kühl. Mit dem Homematic Konfigurator kann ich keine Direktverknüpfung zu Tür-/Fensterkontakten sehen. Alles etwas merkwürdig. Irgendwie scheinen die Verknüpfungen mit addLink nicht so richtig angelegt worden sein.

Ich habe die Testgeräte gestern zu mir nach Hause geholt, muss jetzt nur noch testen…

1 Like

Hallo @job,

so, ich habe jetzt etwas bei mir rumgespielt, bekomme das Problem auf Anhieb aber leider nicht reproduziert. Allerdings habe ich hier nur drei Stellantriebe und hätte erwartet, der Fehler tritt auch auf, wenn ich zwei Stellantriebe mit dem dritten verbinde. Das ist aber leider nicht der Fall. Dafür sind mir aber zwei andere Kleinigkeiten aufgefallen, welche ich gerade noch löse.

Könntest du mir doch noch einmal das gesamte Log ab Druck der Anlerntaste schicken? Das NACK wird generiert, weil versucht wird einen virtuellen Peer zu entfernen, welcher nicht mehr existiert (vermutlich weil er in einem Vorversuch bereits entfernt wurde). Allerdings müsste die Queue danach weiter abgearbeitet werden.

Viele Grüße

Sathya

Mache ich heute abend, kann gerade nicht auf das System. Welcher log level? Reicht 4?

Ja, 4 reicht.

… neue Version mit zumindest den zwei behobenen Problemen (und mqtt-in) ist online.

3 Likes

Heisst das online auf github oder online als nightly build?

Hier ist das Log (ich habe das gefiltert auf Bidcos, sonst wird es riesig):

NACK_received_Popping_from_Queue.txt (170,7 KB)

Es geht um die Geräte:

    │                           │          │               │      │                           │          │                │         │
 23 │ FEFK                      │   3C71DB │    MEQ0716440 │ 00C7 │ HM-Sec-SCo                │      1.0 │             No │      No │      No
 24 │ HTTK                      │   3D0BFF │    MEQ0808946 │ 00C7 │ HM-Sec-SCo                │      1.0 │             No │      No │      No
271 │ FESHK                     │   4CF042 │    NEQ0875801 │ 0095 │ HM-CC-RT-DN               │      1.4 │             No │      No │      No
272 │ FEWT                      │   4DE926 │    NEQ0939649 │ 00AD │ HM-TC-IT-WM-W-EU          │      1.3 │             No │      No │      No
273 │ FESFK                     │   5D05B9 │    OEQ1433713 │ 00C7 │ HM-Sec-SCo                │      1.0 │             No │      No │      No
274 │ FEWHK                     │   4CE90A │    NEQ0873954 │ 0095 │ HM-CC-RT-DN               │      1.4 │            Yes │      No │      No

Das Wandthermostat meint gerade auch, es wäre ein Fenster geöffnet. Auf diesem habe ich die Anlerntaste gedrückt.

Vielen Dank, @sathya

2868 nightly für Raspbian Buster

1 Like

Installation läuft, ich bin gespannt. :wink:

Ich glaube nicht, dass das dein Problem löst. Ich schaue aber gerade.

1 Like

Es sieht so aus, als wenn mqtt-in wieder läuft. Das ist wichtig, denn sonst kann ich eh nicht upgraden. :smiley:

Ich vermute sowieso, dass das Problem erst nach einem Device-Reset weg ist. Ich gehe davon aus, dass beim Verbinden der Geräte etwas schiefläuft. Das “NACK…” ist nur ein Folgefehler, der durch die fehlerhafte Direktverknüpfung getriggert wird. Ich konnte früher die ganzen Direlktverbindungen mit dme Homematic-Konfigurator anschauen, das geht aktuell nicht mehr. Das Tool stürzt dabei ab.

Hallo @job,

Das “NACK…” ist nur ein Folgefehler, der durch die fehlerhafte Direktverknüpfung getriggert wird.

Das kann durchaus sein. Dennoch sollte die Queue weiter abgearbeitet werden. Das sollte im nächsten Nightly so sein. Ich kompiliere über Nacht, d. h. morgen früh sollte es online sein (Version bleibt 2868).

Achte direkt nach dem Update auf das Log. Entweder durch ein Wake-up-Paket oder durch Druck der Anlerntaste sollte diese jetzt abgearbeitet werden. Dabei wären alle Fehler, die Auftreten interessant. Könntest du diese hier posten (falls es klappt…)?

Viele Grüße

Sathya

1 Like

Ach so:

Die Direktverknüpfungen eines Peers kannst du dir mit

homegear -e rc 'print_v($hg->getLinks(<Peer ID>));'

ansehen.

1 Like

Ich habe im Log nichts Auffälliges gesehen. Ich habe vor dem Update den Level auf 4 gestellt. Ich poste das später hier, wenn gewünscht. Ich habe das Update gegen 10:30 durchgeführt.

Mir ist aufgefallen, dass ein Heizkörper, der gestern auf “Config Pending” stand, es jetzt nicht mehr ist. Das ist schonmal Super. Es gab ein paar “NACK”-Meldungen, die hatten jetzt ein “in response to” dabei.

Aktuell treten keine “NACK” mehr auf. Ich lasse das Log jetzt ersmal auf Level 4, damit wir nachvollziehen können, was passiert.

Die Verknüpfungen sehen sinnvoll aus, ich verstehe nicht, wieso der Konfigurator dabei abstürzt. Wie gesagt, früher hatte der das nicht gemacht. (Meine ich zumindest.)

Ich bin begeistert! Klasse!

:+1:

Meine letzten NACKs seit dem Upgrade auf Version 0.8.0-2869.

01/10/20 10:35:31.475 HomeMatic BidCoS packet received (My-Gateway, RSSI: -71 dBm): 09EAA112FD00014CE90A
01/10/20 10:35:31.604 HomeMatic BidCoS packet received (My-CC1101-Module, RSSI: -65 dBm): 0AEA80024CE90AFD000100
01/10/20 10:35:31.605 HomeMatic BidCoS packet received (My-Gateway, RSSI: -61 dBm): 0AEA80024CE90AFD000100
01/10/20 10:35:31.704 Module HomeMatic BidCoS: TI CC110X "My-CC1101-Module": Info: Sending (My-CC1101-Module): 1024A001FD00014CE90A03023D0BFF0100 Planned sending time: 01/10/20 10
01/10/20 10:35:31.727 HomeMatic BidCoS packet received (My-Gateway, RSSI: -71 dBm): 1024A001FD00014CE90A03023D0BFF0100
01/10/20 10:35:31.851 HomeMatic BidCoS packet received (My-CC1101-Module, RSSI: -65 dBm): 0A2480024CE90AFD000180

01/10/20 10:35:31.851 Module HomeMatic BidCoS: Warning: NACK received from 0x4CE90A. Popping from queue anyway. If the device doesn't seem to work, please reset it to factory defa
01/10/20 10:35:31.851 Module HomeMatic BidCoS: Error: NACK received from 0x4CE90A in response to 1024A001FD00014CE90A03023D0BFF0100.
01/10/20 10:35:31.852 HomeMatic BidCoS packet received (My-Gateway, RSSI: -61 dBm): 0A2480024CE90AFD000180

01/10/20 10:35:31.950 Module HomeMatic BidCoS: TI CC110X "My-CC1101-Module": Info: Sending (My-CC1101-Module): 102AA001FD00014CE90A03023C71DB0100 Planned sending time: 01/10/20 10
01/10/20 10:35:31.974 HomeMatic BidCoS packet received (My-Gateway, RSSI: -71 dBm): 102AA001FD00014CE90A03023C71DB0100
01/10/20 10:35:32.097 HomeMatic BidCoS packet received (My-CC1101-Module, RSSI: -65 dBm): 0A2A80024CE90AFD000180

01/10/20 10:35:32.097 Module HomeMatic BidCoS: Warning: NACK received from 0x4CE90A. Popping from queue anyway. If the device doesn't seem to work, please reset it to factory defa
01/10/20 10:35:32.097 Module HomeMatic BidCoS: Error: NACK received from 0x4CE90A in response to 102AA001FD00014CE90A03023C71DB0100.

01/10/20 10:35:32.098 HomeMatic BidCoS packet received (My-Gateway, RSSI: -61 dBm): 0A2A80024CE90AFD000180
01/10/20 10:35:32.196 Module HomeMatic BidCoS: TI CC110X "My-CC1101-Module": Info: Sending (My-CC1101-Module): 1031A001FD00014CE90A03025D05B90100 Planned sending time: 01/10/20 10
01/10/20 10:35:32.220 HomeMatic BidCoS packet received (My-Gateway, RSSI: -71 dBm): 1031A001FD00014CE90A03025D05B90100
01/10/20 10:35:32.343 HomeMatic BidCoS packet received (My-CC1101-Module, RSSI: -65 dBm): 0A3180024CE90AFD000100
01/10/20 10:35:32.343 HomeMatic BidCoS packet received (My-Gateway, RSSI: -61 dBm): 0A3180024CE90AFD000100
01/10/20 10:35:32.443 Module HomeMatic BidCoS: TI CC110X "My-CC1101-Module": Info: Sending (My-CC1101-Module): 0A88A011FD00014CE90A84 Planned sending time: 01/10/20 10:35:32.442
01/10/20 10:35:32.461 HomeMatic BidCoS packet received (My-Gateway, RSSI: -71 dBm): 0A88A011FD00014CE90A84
01/10/20 10:35:32.595 HomeMatic BidCoS packet received (My-CC1101-Module, RSSI: -65 dBm): 0F8880024CE90AFD000101042A103B00
01/10/20 10:35:32.595 Module HomeMatic BidCoS: Info: Queue 2 is empty and there are no pending queues.
01/10/20 10:35:32.595 HomeMatic BidCoS packet received (My-Gateway, RSSI: -61 dBm): 0F8880024CE90AFD000101042A103B00
01/10/20 10:35:32.597 Module HomeMatic BidCoS: Info: BOOST_STATE on channel 4 of HomeMatic BidCoS peer 274 with serial number NEQ0873954 was set to 0x00.

Danach, also seit ca. 2 Stunden keine mehr. Das war sonst ungefähr alle 5 Minuten.

Aktuell meint auch kein Gerät, dass Fenster geöffnet wären.

Danke, @sathya.

Mit den NACKs kann ich leben. Es wird in allen Fällen versucht, eine Direktverknüpfung zu entfernen, die offenbar nicht mehr existiert. Das ist aus meiner Sicht nicht schlimm. Wenn das also alle NACKs waren, scheint wirklich alles in Ordnung.