Zigbee: kein pairing obwohl Instanz grün (Stick verbunden).

[hukio]

@arteck Das pairing ist kein Problem. Hauptsache die Objekte bleiben erhalten. Die Kacheln der ersten gepairten Geräte sind wiederbelebt worden. Habe versucht den Würfel zu pairen. Das ist mir vorgestern nicht gelungen (dann fing das Unglück an). Es geht immer noch nicht. Der Würfel hat über Wochen mit dem alten Stick funktioniert. Hier das Log:

zigbee.0	2020-04-06 09:56:56.104	error	(12062) Failed to interview '0x00158d00029a900d', device has not succesfully been paired. undefined
zigbee.0	2020-04-06 09:56:45.610	info	(12062) Zigbee: stop joining
zigbee.0	2020-04-06 09:55:56.084	info	(12062) Starting interview of '0x00158d00029a900d'
zigbee.0	2020-04-06 09:55:44.547	info	(12062) Zigbee: allowing new devices to join.

Hatte es damals mehrfach versucht. Das interview funktioniert nicht.

Kannst Du mir sagen, was das Problem war, bzw. was ich falsch gemacht habe. Es hat ja damit begonnen, daß ich version 1.0.2 eingespielt habe zurück von 1.0.3. Das hat nicht funktioniert.

[arteck]

@hukio es hat mit dem Würfel begonnen.. das dieser nicht rein kam wie gerade eben auch

Failed to interview '0x00158d00029a900d', device has not succesfully been paired. undefined

nochmal geht nicht dann nochmal...

nix löschen, nix zurücksetzten...einfach immer wieder weiter probieren...

ist dies nicht der Fall nochmal Pairen.. geht nicht.. adapter stoppen.. stick kurz abziehen.. wieder rein.. adapter starten

manchmal ist das so..

wie weit bist du vom Stick ?? ab und an klappt der Hop nicht.. dann ist es besser direkt am stick da zu sein

[hukio]

@arteck weniger als 1 Meter. Als ich umstellte, hatte ich mit keinem meiner > 30 Geräte irgendwelche Schwierigkeiten (alle mußte ich neu pairen), außer mit dem Würfel. Ich habe es bestimmt 10 Mal probiert bevor ich mich zu weiteren Maßnahmen hinreißen ließ.

[hukio]

@arteck Habe Deinen Rat befolgt. Adapter gestoppt, Stick abgezogen, Adapter gestartet - und das Pairen geht nicht mehr

zigbee.0	2020-04-06 10:34:06.707	info	(27801) Zigbee: stop joining
zigbee.0	2020-04-06 10:33:05.647	info	(27801) Zigbee: allowing new devices to join.
zigbee.0	2020-04-06 10:32:50.337	info	(27801) Zigbee started
zigbee.0	2020-04-06 10:32:50.336	info	(27801) 0x000d6ffffe2e4670 (addr 61837): E1746 - IKEA TRADFRI signal repeater (Router)
zigbee.0	2020-04-06 10:32:50.330	info	(27801) Currently 1 devices are joined:
zigbee.0	2020-04-06 10:32:50.322	info	(27801) --> transmitPower : high
zigbee.0	2020-04-06 10:32:50.318	info	(27801) Disable LED
zigbee.0	2020-04-06 10:32:50.314	info	(27801) Coordinator firmware version: {"type":"zStack30x","meta":{"transportrev":2,"product":2,"majorrel":2,"minorrel":7,"maintrel":2,"revision":20200327}}
zigbee.0	2020-04-06 10:32:48.142	info	(27801) Starting Zigbee...
zigbee.0	2020-04-06 10:32:48.106	info	(27801) starting. Version 1.0.4 in /opt/iobroker/node_modules/iobroker.zigbee, node: v10.17.0
host.raspi-3	2020-04-06 10:32:45.578	info	instance system.adapter.zigbee.0 started with pid 27801
host.raspi-3	2020-04-06 10:32:45.551	info	"system.adapter.zigbee.0" enabled
host.raspi-3	2020-04-06 10:32:21.180	info	instance system.adapter.zigbee.0 terminated with code 156 (156)
zigbee.0	2020-04-06 10:32:20.661	info	(19450) Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason
zigbee.0	2020-04-06 10:32:20.660	info	(19450) terminating
zigbee.0	2020-04-06 10:32:20.624	info	(19450) Zigbee: disabling joining new devices.
zigbee.0	2020-04-06 10:32:20.621	info	(19450) cleaned everything up...
zigbee.0	2020-04-06 10:32:20.619	info	(19450) Got terminate signal TERMINATE_YOURSELF
host.raspi-3	2020-04-06 10:32:20.617	info	stopInstance system.adapter.zigbee.0 send kill signal
host.raspi-3	2020-04-06 10:32:20.611	info	stopInstance system.adapter.zigbee.0 (force=false, process=true)
host.raspi-3	2020-04-06 10:32:20.609	info	"system.adapter.zigbee.0" disabled

[arteck]

@hukio laut dem log hast du nur den Repeater angelernt .. oder noch was ? was im Log nicht steht

[hukio]

@arteck ich hatte auch einen Xiaomi Fensterkontakt angelernt. Kachel war aktiv und Map auch. Diesen habe ich versucht neu zu pairen (um das Pairen zu testen, da der Würfel nicht mehr ging (dessen Kachel und Map waren auch zunächst aktiv). Es sieht so aus als ob das erneute Pairen die Geräte wieder herausgeworfen hätte. Soll ich den Repeater nochmals pairen?

[arteck]

@hukio nein.. warte

[arteck]

zeig mir mal die

/opt/iobroker/iobroker-data/zigbee_0/shepherd.db

[hukio]

@arteck hier ist das file
shepherd.db
der Würfel ist ....a900d

[arteck]

@hukio da steht aber nix vo einem Fensterkontakt ...

der Coordinator ist da
der Repeater auch

und der missversuch den Würfel zu connecten
und du drückst auch diesen Knopp zum Pairen

[hukio]

@arteck habe wahrscheinlich den Knopf auf der Geräteseite gedrückt. Versuche es jetzt mit dem der Einstellungsseite. Kein Unterschied funktioniert auch nicht

[arteck]

@hukio das ist egal wo.. hauptsache dieser knopp .. nicht der in irgendeiner Kachel am Gerät

[hukio]

@arteck Es wird immer misteriöser. Ich habe inzwischen auf einem anderem RPI iobroker installiert. Den zigbee adapter geladen (version 1.0.3 ist gekommen). Den alten cc2531 Stick angeschlossen mit Kanal 11. Einstellungen wie früher. Ich kann auch hier nicht pairen. Kein Eintrag in der shepherd.db. Habe noch einen OSRAM plug probiert (router), da ich auf dem Stick die source routing firmware habe. Habe natürlich den neuen Stick vorher abgezogen.

[arteck]

@hukio also irgendwas machst du was ich nicht verstehe

ergo.. komm heute in TS bin ab 19 uhr schau ich mir das Live an.. ansonsten kommen wir nicht zum Punkt

[hukio]

@arteck wie komme ich in TS? Habe ich noch nicht gemacht. Auf jeden Fall nochmals Danke.

[arteck]

@hukio https://www.youtube.com/watch?v=wQEoM5HW_ns

bin ab 19 uhr da

und lad dir schon mal anydesk runter

[hukio]

@arteck zur weiteren Information:
Habe den CC2538 am alternativen RPI3 angeschlossen mit Kanal 11. Pairing ging. Habe Kontakt, OSRAM plug und Tradfri repeater gepaired. Zwischendurch auch Würfel (gab aber nur Kachel mit Fragezeichen). Habe Würfel wiederholt, Kachel weg. Habe Adapter gestoppt. Stick abgezogen. Adapter wieder gestartet. Habe daraufhin Würfel und Kontakt neu gepairt-> Kontakt Kachel weg. Die gepairtenGeräte werden aus der shepherd.db ausgetragen, nicht aber der nicht definierte Würfel!
shepherd.db
Das Verhalten ist gleich wie es an dem RPI4 war.

[ts020339]

Hallo Zusammen,

habe seit 5. April ähnliche Probleme mit meinem Zigbee Adapter CC2531. Ich bekomme keine Verbindung mehr zu angelernten Geräten und ein neu Anlernen funktioniert auch nicht mehr.
Mein Setup:
Ich habe ein iobroker Host System und einen RPI3 mit dem Zigbee Adapter, bei dem ein iobroker Client in einem Docker Container läuft. Das device /dev/ttyACM0 wird in den Container reingereicht und hat dort die korrekten Zugriffsrechte vom iobroker user (getestet mit dem hier weiter oben verlinkten Artikel zu den Zugriffsrechten).

Ich habe mittlerweile alles gelöscht und den Adapter komplett neu installiert, ohne Erfolg. Habe auch jetzt wirklich versucht, alle Hinweise hier im Forum durchzuarbeiten, ich bekomme es leider nicht hin. (sorry wenn mein Post so groß wird, gibt es einen besseren Weg die Logs zu posten als über die "code"-Funktion?)

Wenn ich den RPI3 komplett neu boote wird die Adapter Instanz "grün"

und im Log steht folgendes:

zigbee.1	2020-04-10 15:15:40.978	silly	(414) States system redis pmessage system.adapter.zigbee.1.sigKill/system.adapter.zigbee.1.sigKill:null
zigbee.1	2020-04-10 15:12:56.343	info	(414) Zigbee started
zigbee.1	2020-04-10 15:12:56.340	info	(414) Currently no devices.
zigbee.1	2020-04-10 15:12:56.323	info	(414) --> transmitPower : normal
zigbee.1	2020-04-10 15:12:56.311	debug	(414) Zigbee network parameters: {"panID":6754,"extendedPanID":"0xdddddddddddddddd","channel":16}
zigbee.1	2020-04-10 15:12:56.301	info	(414) Coordinator firmware version: {"type":"zStack12","meta":{"transportrev":2,"product":0,"majorrel":2,"minorrel":6,"maintrel":3,"revision":20190608}}
zigbee.1	2020-04-10 15:12:56.297	debug	(414) zigbee-herdsman started
zigbee.1	2020-04-10 15:12:47.981	debug	(414) Starting zigbee-herdsman...
zigbee.1	2020-04-10 15:12:47.976	info	(414) Starting Zigbee...
zigbee.1	2020-04-10 15:12:47.844	info	(414) starting. Version 1.0.4 in /opt/iobroker/node_modules/iobroker.zigbee, node: v10.19.0

Einstellungen im Adapter:

gehe ich jetzt im Adapter auf den Pairingbutton, geht zwar das Pairing Fernster auf, aber der Countdown läuft nicht

Im Log steht das hier:

zigbee.1	2020-04-10 15:22:48.671	debug	(414) sendTo "getMap" to system.adapter.admin.0 from system.adapter.zigbee.1
zigbee.1	2020-04-10 15:22:48.670	debug	(414) getMap result: {"lqis":[{"parent":"undefined","networkAddress":0,"ieeeAddr":"0x00124b0018e1f7dd","lqi":"undefined","relationship":0,"depth":0,"status":"offline"}],"routing":[]}
zigbee.1	2020-04-10 15:22:48.668	debug	(414) Get map succeeded [{"parent":"undefined","networkAddress":0,"ieeeAddr":"0x00124b0018e1f7dd","lqi":"undefined","relationship":0,"depth":0,"status":"offline"}]
zigbee.1	2020-04-10 15:22:48.666	debug	(414) Routing table succeeded for 'Coordinator'
zigbee.1	2020-04-10 15:22:48.664	debug	(414) Routing for 'Coordinator': undefined
zigbee.1	2020-04-10 15:22:48.663	debug	(414) Failed to execute routing table for 'Coordinator'. "Error: AREQ - ZDO - mgmtRtgRsp after 10000ms\n at Timeout.object.timer.setTimeout [as _onTimeout] (/opt/iobroker/node_modules/zigbee-herdsm
zigbee.1	2020-04-10 15:22:38.655	debug	(414) LQI succeeded for 'Coordinator'
zigbee.1	2020-04-10 15:22:38.651	debug	(414) Failed to execute LQI for 'Coordinator'. "Error: AREQ - ZDO - mgmtLqiRsp after 10000ms\n at Timeout.object.timer.setTimeout [as _onTimeout] (/opt/iobroker/node_modules/zigbee-herdsman/dist/ut
zigbee.1	2020-04-10 15:22:30.698	silly	(414) States user redis pmessage zigbee.1.*/zigbee.1.info.pairingMessage:{"val":"Pairing started ","ack":false,"ts":1586524950693,"q":0,"from":"system.adapter.zigbee.1","user":"system.user.admin","lc"
zigbee.1	2020-04-10 15:22:30.690	debug	(414) sendTo "letsPairing" to system.adapter.admin.0 from system.adapter.zigbee.1: Start pairing!
zigbee.1	2020-04-10 15:22:30.685	info	(414) Zigbee: allowing new devices to join.
zigbee.1	2020-04-10 15:22:30.678	silly	(414) States system redis pmessage io.messagebox.system.adapter.zigbee.1/io.messagebox.system.adapter.zigbee.1:{"command":"letsPairing","message":{},"from":"system.adapter.admin.0","callback":{"messag
zigbee.1	2020-04-10 15:22:29.045	debug	(414) sendTo "getBinding" to system.adapter.admin.0 from system.adapter.zigbee.1
zigbee.1	2020-04-10 15:22:29.043	debug	(414) getBinding result: []
zigbee.1	2020-04-10 15:22:28.965	silly	(414) States system redis pmessage io.messagebox.system.adapter.zigbee.1/io.messagebox.system.adapter.zigbee.1:{"command":"getBinding","message":{},"from":"system.adapter.admin.0","callback":{"message
zigbee.1	2020-04-10 15:22:28.959	debug	(414) sendTo "listUart" to system.adapter.admin.0 from system.adapter.zigbee.1
zigbee.1	2020-04-10 15:22:28.957	debug	(414) List of ports: [{"comName":"/dev/ttyAMA0"},{"comName":"/dev/ttyACM0"}]
zigbee.1	2020-04-10 15:22:28.747	debug	(414) sendTo "getDevices" to system.adapter.admin.0 from system.adapter.zigbee.1
zigbee.1	2020-04-10 15:22:28.733	debug	(414) getDevices result: [{"_id":"0x00124b0018e1f7dd","icon":"img/unknown.png","paired":true,"info":{"type":"device","device":{"ID":1,"_type":"Coordinator","_ieeeAddr":"0x00124b0018e1f7dd","_networkAd
zigbee.1	2020-04-10 15:22:28.671	debug	(414) sendTo "getGroups" to system.adapter.admin.0 from system.adapter.zigbee.1
zigbee.1	2020-04-10 15:22:28.670	debug	(414) getGroups result: {"1":"Sensoren","2":"Schaltsteckdosen"}
zigbee.1	2020-04-10 15:22:28.579	debug	(414) sendTo "getLibData" to system.adapter.admin.0 from system.adapter.zigbee.1
zigbee.1	2020-04-10 15:22:28.572	silly	(414) States system redis pmessage io.messagebox.system.adapter.zigbee.1/io.messagebox.system.adapter.zigbee.1:{"command":"getLibData","message":{"key":"cidList"},"from":"system.adapter.admin.0","call
zigbee.1	2020-04-10 15:22:28.569	silly	(414) States system redis pmessage io.messagebox.system.adapter.zigbee.1/io.messagebox.system.adapter.zigbee.1:{"command":"getGroups","message":{},"from":"system.adapter.admin.0","callback":{"message"
zigbee.1	2020-04-10 15:22:28.561	silly	(414) States system redis pmessage io.messagebox.system.adapter.zigbee.1/io.messagebox.system.adapter.zigbee.1:{"command":"getMap","message":{},"from":"system.adapter.admin.0","callback":{"message":{}
zigbee.1	2020-04-10 15:22:28.555	silly	(414) States system redis pmessage io.messagebox.system.adapter.zigbee.1/io.messagebox.system.adapter.zigbee.1:{"command":"getDevices","message":{},"from":"system.adapter.admin.0","callback":{"message
zigbee.1	2020-04-10 15:22:28.521	silly	(414) States system redis pmessage io.messagebox.system.adapter.zigbee.1/io.messagebox.system.adapter.zigbee.1:{"command":"listUart","message":null,"from":"system.adapter.admin.0","callback":{"message

Und jetzt noch eine weiter Merkwürdigkeit. Wenn ich jetzt den Adapter kurz stoppe und wieder starte, wird dieser niemals wieder grün (bis zum nächsten Reboot des RPI) und im Log kommt folgende Fehlermeldung:

zigbee.1	2020-04-10 15:31:13.149	silly	(439) States user redis pmessage zigbee.1.*/zigbee.1.info.connection:{"val":false,"ack":false,"ts":1586525473144,"q":0,"from":"system.adapter.zigbee.1","user":"system.user.admin","lc":1586525445076}
zigbee.1	2020-04-10 15:31:13.136	error	(439) Error: Error while opening serialport 'Error: Error Resource temporarily unavailable Cannot lock port' at Znp.<anonymous> (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp
zigbee.1	2020-04-10 15:31:13.132	error	(439) Failed to start Zigbee
zigbee.1	2020-04-10 15:31:07.607	debug	(439) Starting zigbee-herdsman...
zigbee.1	2020-04-10 15:31:07.606	info	(439) Starting Zigbee...
zigbee.1	2020-04-10 15:31:07.604	info	(439) Try to reconnect. 1 attempts left
zigbee.1	2020-04-10 15:30:57.609	silly	(439) States user redis pmessage zigbee.1.*/zigbee.1.info.connection:{"val":false,"ack":false,"ts":1586525457604,"q":0,"from":"system.adapter.zigbee.1","user":"system.user.admin","lc":1586525445076}
zigbee.1	2020-04-10 15:30:57.600	error	(439) Error: Failed to connect to the adapter (Error: SRSP - SYS - ping after 6000ms) at ZStackAdapter.<anonymous> (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/adapter/zStackAd
zigbee.1	2020-04-10 15:30:57.597	error	(439) Failed to start Zigbee
zigbee.1	2020-04-10 15:30:45.111	silly	(439) States user redis pmessage zigbee.1.*/zigbee.1.info.connection:{"val":false,"ack":false,"ts":1586525445076,"q":0,"from":"system.adapter.zigbee.1","user":"system.user.admin","lc":1586525445076}
zigbee.1	2020-04-10 15:30:45.103	silly	(439) States system redis pmessage system.adapter.zigbee.1.logLevel/system.adapter.zigbee.1.logLevel:{"val":"silly","ack":true,"ts":1586525445056,"q":0,"from":"system.adapter.zigbee.1","lc":1586524368
zigbee.1	2020-04-10 15:30:44.760	debug	(439) Starting zigbee-herdsman...
zigbee.1	2020-04-10 15:30:44.755	info	(439) Starting Zigbee...
zigbee.1	2020-04-10 15:30:44.614	info	(439) starting. Version 1.0.4 in /opt/iobroker/node_modules/iobroker.zigbee, node: v10.19.0
host.ioBroker_Client_HomeAutomation	2020-04-10 15:30:38.356	info	instance system.adapter.zigbee.1 started with pid 439
host.ioBroker_Client_HomeAutomation	2020-04-10 15:30:38.304	info	"system.adapter.zigbee.1" enabled

Bin für wirklich jede Hilfe dankbar!

Grüße,

Tim

[arteck]

@ts020339
zuerst installiert du die neue Version vom GIT
dann
mach aus kanal 16 -> 15

ist das auch der namen den du vergeben hast für den slave

[ts020339]

@arteck : danke für die Hilfe!
Habe Version aus dem git installiert: 1.0.4 (in den change logs wird auch eine Version 1.1.0 erwähnt, die finde ich allerdings nirgends)
Kanal umgestellt, Einstellungen jetzt wie folgt:

@arteck said in Zigbee: kein pairing obwohl Instanz grün (Stick verbunden).:

ist das auch der namen den du vergeben hast für den slave

ja, der Raspi Client an dem der Stick hängt heißt so

Leider wird der Adapter nicht grün:

zigbee.1	2020-04-11 10:43:03.843	info	(785) Try to reconnect. 1 attempts left
zigbee.1	2020-04-11 10:42:53.847	silly	(785) States user redis pmessage zigbee.1.*/zigbee.1.info.connection:{"val":false,"ack":false,"ts":1586594573843,"q":0,"from":"system.adapter.zigbee.1","user":"system.user.admin","lc":1586525445076}
zigbee.1	2020-04-11 10:42:53.839	error	(785) Error: Failed to connect to the adapter (Error: SRSP - SYS - ping after 6000ms) at ZStackAdapter.<anonymous> (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/adapter/zStackAd
zigbee.1	2020-04-11 10:42:53.836	error	(785) Failed to start Zigbee
zigbee.1	2020-04-11 10:42:41.390	silly	(785) States user redis pmessage zigbee.1.*/zigbee.1.info.connection:{"val":false,"ack":false,"ts":1586594561357,"q":0,"from":"system.adapter.zigbee.1","user":"system.user.admin","lc":1586525445076}
zigbee.1	2020-04-11 10:42:41.382	silly	(785) States system redis pmessage system.adapter.zigbee.1.logLevel/system.adapter.zigbee.1.logLevel:{"val":"silly","ack":true,"ts":1586594561346,"q":0,"from":"system.adapter.zigbee.1","lc":1586594561
zigbee.1	2020-04-11 10:42:40.984	debug	(785) Starting zigbee-herdsman...
zigbee.1	2020-04-11 10:42:40.979	info	(785) Starting Zigbee...
zigbee.1	2020-04-11 10:42:40.848	info	(785) starting. Version 1.0.4 in /opt/iobroker/node_modules/iobroker.zigbee, node: v10.19.0
host.ioBroker_Client_HomeAutomation	2020-04-11 10:42:34.651	info	instance system.adapter.zigbee.1 started with pid 785
host.ioBroker_Client_HomeAutomation	2020-04-11 10:42:33.619	info	Restart adapter system.adapter.zigbee.1 because enabled