Probleme nach ZWave Update mit ZME_WALLC-S

SirHenri

Hat keiner eine Idee? Das Problem besteht immer noch.
Kann ein Update auf die 1.7 Version helfen?
Gruß
Andreas

arteck

@SirHenri probier aus.. kaputt machen kannst du dabei nix

SirHenri

@arteck hab ich dann mal gemacht; Problem mit den ZME_WALLC-S ist nicht besser geworden.
Außerdem ist eine Meldung über vulnerabilites aufgelaufen (Zeile 3), die ich nicht weg bekommen. Muss ich?

iobroker	2019-11-12 20:47:59.810	info	got /opt/iobroker/node_modules/iobroker.zwave/admin
iobroker	2019-11-12 20:47:59.699	info	run `npm audit fix` to fix them, or `npm audit` for details
iobroker	2019-11-12 20:47:59.699	info	found 80 vulnerabilities (49 low, 31 high)
iobroker	2019-11-12 20:47:59.699	info	removed 5 packages, updated 1 package and audited 8206 packages in 31.441s
iobroker	2019-11-12 20:47:59.699	info	+ iobroker.zwave@1.7.0
iobroker	2019-11-12 20:47:59.699	info	npm WARN optional SKIPPING OPTIONAL DEPENDENCY: osx-temperature-sensor@1.0.4 (node_modules/osx-temperature-sensor):npm WARN notsup SKIPPING OPTIONAL DEPENDENCY: Unsupported platform for osx-temperatu
iobroker	2019-11-12 20:47:57.551	info	---> find /usr/local/etc/ -name 'manufacturer_specific.xml' -exec grep -H 'Revision="52"' '{}' \; 2>/dev/null
iobroker	2019-11-12 20:47:57.550	info	manufacturer_specific.xml found in /usr/local/etc/openzwave/manufacturer_specific.xml
iobroker	2019-11-12 20:47:57.495	info	---> find /usr/local/etc/ -name 'manufacturer_specific.xml' 2>/dev/null
iobroker	2019-11-12 20:47:57.166	info	> node lib/preinstall.js
iobroker	2019-11-12 20:47:57.166	info	> iobroker.zwave@1.7.0 preinstall /opt/iobroker/node_modules/iobroker.zwave
iobroker	2019-11-12 20:47:26.935	info	npm install https://github.com/ioBroker/ioBroker.zwave/tarball/master --production --save --prefix "/opt/iobroker" (System call)
iobroker	2019-11-12 20:47:26.270	info	install https://github.com/ioBroker/ioBroker.zwave/tarball/master
iobroker	2019-11-12 20:47:25.713	info	url "https://github.com/ioBroker/ioBroker.zwave/tarball/master" zwave --debug

SirHenri

@SirHenri noch ein zwei Sachen, die Auffallen

Meldung aus dem log:

zwave.0	2019-11-12 21:28:15.550	error	Unknown command: getNumberOfInstances

ist öfter nacheinander im log zu finden - problematisch?

Zum Anderen ist in den Abbildungen zu den adapter settings z.B. auf

https://www.npmjs.com/package/iobroker.zwave

die Möglichkeit abgebildet bei "Force objects re-init" einen Haken zu setzten - den gibt's bei mir nicht

SirHenri

@SirHenri Alles noch mal auf Anfang;
Instanz gelöscht; Adapter gelöscht
Installation der 1.7.0 aus dem Git
Adapter startet nicht sauber:

host.rockpro64	2019-11-14 07:16:17.512	info	Restart adapter system.adapter.zwave.0 because enabled
host.rockpro64	2019-11-14 07:16:17.512	error	instance system.adapter.zwave.0 terminated with code null ()
host.rockpro64	2019-11-14 07:16:17.511	warn	instance system.adapter.zwave.0 terminated due to SIGSEGV
host.rockpro64	2019-11-14 07:16:17.511	error	Caught by controller[0]: at Decoder.add (/opt/iobroker/node_modules/socket.io-parser/index.js:246:12)
host.rockpro64	2019-11-14 07:16:17.511	error	Caught by controller[0]: at Decoder.Emitter.emit (/opt/iobroker/node_modules/component-emitter/index.js:134:20)
host.rockpro64	2019-11-14 07:16:17.511	error	Caught by controller[0]: at Decoder.<anonymous> (/opt/iobroker/node_modules/component-bind/index.js:21:15)
host.rockpro64	2019-11-14 07:16:17.511	error	Caught by controller[0]: at Manager.ondecoded (/opt/iobroker/node_modules/socket.io-client/lib/manager.js:332:8)
host.rockpro64	2019-11-14 07:16:17.511	error	Caught by controller[0]: at Manager.Emitter.emit (/opt/iobroker/node_modules/socket.io-client/node_modules/component-emitter/index.js:133:20)
host.rockpro64	2019-11-14 07:16:17.511	error	Caught by controller[0]: at Manager.<anonymous> (/opt/iobroker/node_modules/component-bind/index.js:21:15)
host.rockpro64	2019-11-14 07:16:17.511	error	Caught by controller[0]: at Socket.onpacket (/opt/iobroker/node_modules/socket.io-client/lib/socket.js:236:12)
host.rockpro64	2019-11-14 07:16:17.511	error	Caught by controller[0]: at Socket.onack (/opt/iobroker/node_modules/socket.io-client/lib/socket.js:312:9)
host.rockpro64	2019-11-14 07:16:17.511	error	Caught by controller[0]: at Socket.<anonymous> (/opt/iobroker/node_modules/iobroker.zwave/main.js:536:51)
host.rockpro64	2019-11-14 07:16:17.510	error	Caught by controller[0]: at JSON.parse (<anonymous>)
host.rockpro64	2019-11-14 07:16:17.509	error	Caught by controller[0]: SyntaxError: Unexpected end of JSON input
zwave.0	2019-11-14 07:16:16.506	error	SyntaxError: Unexpected end of JSON input at JSON.parse (<anonymous>) at Socket.<anonymous> (/opt/iobroker/node_modules/iobroker.zwave/main.js:536:51) at Socket.onack (/opt/iobroker/node_m
zwave.0	2019-11-14 07:16:16.503	error	uncaught exception: Unexpected end of JSON input
zwave.0	2019-11-14 07:16:14.745	info	starting. Version 1.7.0 in /opt/iobroker/node_modules/iobroker.zwave, node: v10.17.0

vulnerabilities (49 low, 31 high) bestehen weiter

interessanter Weise sieht die Geräteübersicht anders aus, als bei der letzten 1.7. Installation

Ampel bestenfalls gelb

cburghardt

@SirHenri das könnte ein Bug sein, dazu bräuchte ich bitte einen GitHub Eintrag

cburghardt

@SirHenri said in Probleme nach ZWave Update mit ZME_WALLC-S:

ist öfter nacheinander im log zu finden - problematisch?

Da passt die Version des Admin Frontend nicht mit dem Backend zusammen. Der Adapter wurde nicht korrekt installiert.

Zum Anderen ist in den Abbildungen zu den adapter settings z.B. auf
https://www.npmjs.com/package/iobroker.zwave
die Möglichkeit abgebildet bei "Force objects re-init" einen Haken zu setzten - den gibt's bei mir nicht

Kann man ignorieren, ist noch eine alte Abbildung.

SirHenri

@cburghardt mach ich gerne fertig, habe ich aber noch nie gemacht

muss jetzt erst mal los, melde mich heute Nachmittag - und werde dann wohl erst mal ein Account im Git anlegen?

SirHenri

@cburghardt ist erledigt

SirHenri

Ich wollte mal einen Zwischenstand mitteilen - das Problem besteht weiter.

Da die Version 1.7.1 bei mir immer noch Fehler erzeugt, bin ich zurück auf die 1.6. Den Tatster hatte ich 3x aus dem System vollständig raus (in beiden Adapterversionen; er hat 3x eine neue ID bekommen). In allen drei Versuchen habe ich nur die schon beschriebenen states erzeugt bekommen.
Weitere Veränderungen: neue Batterie, USB Dongle mit Verlängerung versorgt, um evt. Abschirmung direkt am Rechner auszuschließen.
Der Abstand zwischen Dongle und Taster beträgt bei Inklusion Exklusion ca. 1,5m.
Das Log sieht so aus, als wenn der Taster sich zu früh schlafen legt. Kann ich das unterbinden?
Hat irgendjemand eine Idee, welche(n) weiteren Parameter ich verändern kann?

2019-11-21 12:16:50.585 Info, Node021, Response RTT 2289 Average Response RTT 1980
2019-11-21 12:16:50.585 Info, Node021,   Opening config param file /usr/local/etc/openzwave/popp/009303.xml
2019-11-21 12:16:50.589 Info, Node021, (112 - COMMAND_CLASS_CONFIGURATION) - Compatibility Flags:
2019-11-21 12:16:50.589 Info, Node021, (112 - COMMAND_CLASS_CONFIGURATION) - State Flags:
2019-11-21 12:16:50.589 Info, Node021, 	 CCVersion: 1
2019-11-21 12:16:50.589 Info, Node021, 	 InNif: true
2019-11-21 12:16:50.589 Info, Node021, 	 StaticRequests: 5
2019-11-21 12:16:50.590 Warning, Missing default list value or vindex from xml configuration: node 21, class 0x70, instance 1, index 21
2019-11-21 12:16:50.590 Warning, Missing default list value or vindex from xml configuration: node 21, class 0x70, instance 1, index 22
2019-11-21 12:16:50.591 Info, Node021, (133 - COMMAND_CLASS_ASSOCIATION) - Compatibility Flags:
2019-11-21 12:16:50.591 Info, Node021, (133 - COMMAND_CLASS_ASSOCIATION) - State Flags:
2019-11-21 12:16:50.591 Info, Node021, 	 CCVersion: 1
2019-11-21 12:16:50.591 Info, Node021, 	 InNif: true
2019-11-21 12:16:50.591 Info, Node021, 	 StaticRequests: 7
2019-11-21 12:16:50.592 Info, Node021, Received manufacturer specific report from node 21: Manufacturer=Popp & Co, Product=009303 Battery Wall Controller
2019-11-21 12:16:50.592 Info, Node021, Node Identity Codes: 0154:0100:0101
2019-11-21 12:16:50.592 Detail, Node021, Notification: Group
2019-11-21 12:16:50.592 Detail, Node021, Notification: Group
2019-11-21 12:16:50.593 Detail, Node021, Notification: Group
2019-11-21 12:16:50.593 Detail, Node021, Notification: Group
2019-11-21 12:16:50.593 Detail, Node021, Notification: Group
2019-11-21 12:16:50.593 Detail, Node021, Notification: NodeNaming
2019-11-21 12:16:58.296 Error, Node021, ERROR: Dropping command, expected response not received after 1 attempt(s)
2019-11-21 12:16:58.296 Detail, Node021, Removing current message
2019-11-21 12:16:58.297 Detail, Node021, Notification: Notification - TimeOut
2019-11-21 12:16:58.297 Detail, 
2019-11-21 12:16:58.297 Info, Node021, Sending (Query) message (Callback ID=0x40, Expected Reply=0x04) - MultiInstanceCmd_Get (Node=21): 0x01, 0x0a, 0x00, 0x13, 0x15, 0x03, 0x60, 0x04, 0x26, 0x25, 0x40, 0xd7
2019-11-21 12:16:58.297 Info, Node021, Encrypted Flag is 0
2019-11-21 12:16:58.306 Detail, Node021,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-11-21 12:16:58.307 Detail, Node021,   ZW_SEND_DATA delivered to Z-Wave stack
2019-11-21 12:16:58.491 Detail, Node021,   Received: 0x01, 0x07, 0x00, 0x13, 0x40, 0x00, 0x00, 0x13, 0xb8
2019-11-21 12:16:58.491 Detail, Node021,   ZW_SEND_DATA Request with callback ID 0x40 received (expected 0x40)
2019-11-21 12:16:58.491 Info, Node021, Request RTT 193 Average Request RTT 112
2019-11-21 12:16:58.491 Detail, Node021,   Expected callbackId was received
2019-11-21 12:17:08.298 Error, Node021, ERROR: Dropping command, expected response not received after 1 attempt(s)
2019-11-21 12:17:08.299 Detail, Node021, Removing current message
2019-11-21 12:17:08.299 Detail, Node021, Notification: Notification - TimeOut
2019-11-21 12:17:08.299 Detail, 
2019-11-21 12:17:08.299 Info, Node021, Sending (Query) message (Callback ID=0x41, Expected Reply=0x04) - MultiInstanceCmd_Get (Node=21): 0x01, 0x0a, 0x00, 0x13, 0x15, 0x03, 0x60, 0x04, 0x27, 0x25, 0x41, 0xd7
2019-11-21 12:17:08.299 Info, Node021, Encrypted Flag is 0
2019-11-21 12:17:08.307 Detail, Node021,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-11-21 12:17:08.308 Detail, Node021,   ZW_SEND_DATA delivered to Z-Wave stack
2019-11-21 12:17:08.482 Detail, Node021,   Received: 0x01, 0x07, 0x00, 0x13, 0x41, 0x00, 0x00, 0x12, 0xb8
2019-11-21 12:17:08.483 Detail, Node021,   ZW_SEND_DATA Request with callback ID 0x41 received (expected 0x41)
2019-11-21 12:17:08.483 Info, Node021, Request RTT 183 Average Request RTT 147
2019-11-21 12:17:08.483 Detail, Node021,   Expected callbackId was received
2019-11-21 12:17:18.300 Error, Node021, ERROR: Dropping command, expected response not received after 1 attempt(s)
2019-11-21 12:17:18.300 Detail, Node021, Removing current message
2019-11-21 12:17:18.300 Detail, Node021, Notification: Notification - TimeOut
2019-11-21 12:17:18.300 Detail, 
2019-11-21 12:17:18.300 Info, Node021, Sending (Query) message (Callback ID=0x42, Expected Reply=0x04) - MultiInstanceCmd_Get (Node=21): 0x01, 0x0a, 0x00, 0x13, 0x15, 0x03, 0x60, 0x04, 0x2b, 0x25, 0x42, 0xd8
2019-11-21 12:17:18.301 Info, Node021, Encrypted Flag is 0
2019-11-21 12:17:18.309 Detail, Node021,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-11-21 12:17:18.309 Detail, Node021,   ZW_SEND_DATA delivered to Z-Wave stack
2019-11-21 12:17:22.716 Detail, Node021,   Received: 0x01, 0x07, 0x00, 0x13, 0x42, 0x01, 0x01, 0xb9, 0x10
2019-11-21 12:17:22.717 Detail, Node021,   ZW_SEND_DATA Request with callback ID 0x42 received (expected 0x42)
2019-11-21 12:17:22.717 Info, Node021, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
2019-11-21 12:17:22.717 Info, Node021,   Node 21 has been marked as asleep
2019-11-21 12:17:22.717 Info, Node021, Node not responding - moving message

cburghardt

@SirHenri der Fehler der Version 1.7.1 wurde nun gefixt, er ist aktuell aber nur in der GitHub Version behoben.
Wegen dem Wallplug würde ich mal bei openzwave nachfragen, da scheint es ein Kommunikationsproblem zu geben.

SirHenri

@cburghardt vielen Dank für die Benachrichtigung, hatte den Fix schon im Github gesehen.
Parallel zu diesem Text installiere ich die 1.7.1 noch mal.
Die Kommunikation ist seit dem Update auf die 1.6 sowie "besonders". Neben dem nicht mehr funktionierendem Taster (der ja mindestens bei einem weiteren Hersteller auch auftritt) hat sich auch bei meinen Bewegungsmeldern (3x Steinel IS 140-2) merkwürdiges Verhalten eingebürgert.
Bei Update auf die 1.6 laufen die Meldungen über detektierte Bewegung nicht mehr als Einbruchsalarm auf, sondern im Bereich "Home_Security_1" - meinetwegen. Beim Einrichten des Adapters gibt's die aber nicht zwingend (kann sein, dass das noch Verbindungsprobleme sind), mit Aktualiserung der Informationen sind sie dann irgenwann da. Ab einem Zeitpunkt, den ich nicht mehr genau benennen kann, gibt es nun Home_Security_1 und..._2; die Bwegung wird in _2 angemeldet. Nach Veränderung der Skripte wieder alles gut - bis zu dem Zeitpunkt gestern abend, oder heute Nacht, bei dem sich die BewMelder gedacht haben, es wäre eine gute Idee, die Bewegung wieder in Home_Security_1 zu melden...
Das Skript werde ich wohl nicht zurück schreiben, sondern ab sofort beide Kanäle (_1 und _2) abfragen. Ist aber irgendwie unbefriedigend.

Welchen Wechsel hat es bei dem hinterlegten OZW Modul gegeben? Damit ich das für einen möglichen Eintrag dort mit angeben kann.

Die Installation der 1.7.1 und das Erzeugen der Instanz sind hier auch sauber durchgelaufen. Ein Fehler beim Scannen der Nodes ist aufgelaufen. Node 16 ist der BewMelder, der am weitesten weg hängt. Ich update die Informationen gerade, hier sind nämlich auch wieder nur die States für/um Home_Security_1 aufgelaufen.

host.rockpro64	2019-11-25 16:32:49.313	info	Restart adapter system.adapter.zwave.0 because enabled
host.rockpro64	2019-11-25 16:32:49.312	info	instance system.adapter.zwave.0 terminated with code NaN ()
host.rockpro64	2019-11-25 16:32:49.311	warn	instance system.adapter.zwave.0 terminated due to SIGABRT
host.rockpro64	2019-11-25 16:32:49.310	error	Caught by controller[0]: what(): Manager.cpp:1514 - InvalidValueIDError (101) Msg: Invalid ValueID passed to GetValueLabel
host.rockpro64	2019-11-25 16:32:49.308	error	Caught by controller[0]: terminate called after throwing an instance of 'OpenZWave::OZWException'
web.0	2019-11-25 16:32:47.823	info	(1709) ==>Connected system.user.admin from ::ffff:192.168.178.201
zwave.0	2019-11-25 16:32:43.723	info	(14003) State created: zwave.0.NODE16.SENSOR_MULTILEVEL.Illuminance_1 = undefined, index = 3, comClass = 49, instance = 1
zwave.0	2019-11-25 16:32:43.721	info	(14003) Channel created: zwave.0.NODE16.SENSOR_MULTILEVEL = 2, index = 3, comClass = 49, instance = 1
zwave.0	2019-11-25 16:32:43.719	info	(14003) State created: zwave.0.NODE16.SENSOR_MULTILEVEL.Illuminance_1 = undefined, index = 3, comClass = 49, instance = 1

"Info aktualisieren" startet bei mir im Moment keine Prozesse (Zeile bei der Geräteübersicht wird nicht kurz blau und die Auswahl bleibt auch auf "Info aktualisieren" stehen) - Ampel ist auch 3x rot...

Vielen Dank für Eure Arbeit

SirHenri

Zwave Adapter neu gestartet, Ampel ist jetzt grün, "Info aktualisieren" bringt auch wie gewohnt neu Infos und Home_Security gibt es jetzt auch wieder bei Node 16 in zweifacher Ausführung.

cburghardt

@SirHenri der Fehler oben deutet auf falsche Informationen in dem openzwave Cache hin. Das wird normal durch das Info aktualisieren behoben.

AlCalzone

@cburghardt @SirHenri v1.7.2 ist jetzt auf npm

SirHenri

@AlCalzone hab s einmal mit einem Update probiert, danach Instanz und Adapter raus und von Null wieder neu - der Adapter behauptet in der Adapteransicht weiterhin eine 1.7.1 zu sein

AlCalzone

@SirHenri

Das Repo hat das Update vermutlich noch nicht gesehen. Alternativ gehts auf der Konsole:

cd /opt/iobroker
npm i iobroker.zwave

SirHenri

ah, ok
ist jetzt auch im Repo, Update ist sauber durchgelaufen

Marsx79

Hallo.

Hier besteht auch das Problem mit dem "heatit z-push button 8" das die Scenen nicht angelegt werden. Nur Scene_Count_1 und Scene_Reset_Timeout.

Grüße
Marcel

SirHenri

@cburghardt sagte in Probleme nach ZWave Update mit ZME_WALLC-S:

Wegen dem Wallplug würde ich mal bei openzwave nachfragen, da scheint es ein Kommunikationsproblem zu geben.

Schätze, wir kommen hier nicht weiter. Liege im Moment krankheitsbedingt flach. Soweit ich das verstanden habe liegt das Problem "hinter" iobroker.zwave; direkt in openzwave und wir müssen da mal unsere (inzwischen habe ich mindestens drei gesehen) Beoachtungen schildern. Ich würde als Grundlage dafür gerne noch raus bekommen, welcher Wechsel in der openzwave Version beim Update auf den Zwave Adapter 1.6 im Broker statt gefunden hat.
Ich vermute das Problem dort.

NEWS

Probleme nach ZWave Update mit ZME_WALLC-S

Support us

1.4k
Online

30.3k
Users

76.3k
Topics

1.2m
Posts

NEWS

Probleme nach ZWave Update mit ZME_WALLC-S

Support us

1.4kOnline

30.3kUsers

76.3kTopics

1.2mPosts

1.4k
Online

30.3k
Users

76.3k
Topics

1.2m
Posts