UPDATE 31.10.: Amazon Alexa - ioBroker Skill läuft aus ?

[steimi]

@Asgothian das hatte ich auch gesehen. Das funktioniert aber nach einem Neustart der Instanz. Ich vermute daher eher ein Timing-Problem beim Start der VM und Start des ioBroker bzw der Instanz des Adapters. Wie gesagt reicht ja meist ein Neustart der Instanz. Teilweise muss in der Konfiguartion der Instanz einfach nochmal der /dev/ttyACM0 im Dropdown ausgewählt werden und das Speichern+Beenden in der Konfig und der Adaper startet.

[Asgothian]

@steimi ich denke dann dauert es einfach zu lange bis proxmox die serielle Schnittstelle weiter reicht. Ggf. Kannst du den Start des iobroker bei einem Neustart verzögern ?

A.

[steimi]

Okay, wäre ein Versuch wert. Wie mache ich das?

[Einstein67]

@Asgothian said in Zigbee adapter nach upgrade gelb:

ich denke dann dauert es einfach zu lange bis proxmox die serielle Schnittstelle weiter reicht

Komisch. Ich hab IOBroker mit Zigbee 1.0.3 Adapter in einem Proxmox Container am laufen, und hab überhaupt keine Timing-Probleme beim starten von IOBroker oder des Containers ,,,

[steimi]

mein Zigbee-Adapter lief die letzte Zeit stabil (auch nach Updates auf die 1.1.1). Heute habe ich dann den js-Controller von der 3.0.16 auf die 3.0.18 aktualisiert. danach startete der Adapter nicht mehr - Meldung: need pairing first. Habe daraufhin die ioBroker-VM in Proxmox 2mal neu gestartet und in den Adapter-Einstellungen von Zigbee den Port nochmal eingestellt und gespeichert. Danach funktioniert es nun wieder. Nachfolgend die Logs von heute (wieder der 'can not lock port-Error).

zigbee.0	2020-04-24 06:01:58.871	info	(4581) Zigbee started
zigbee.0	2020-04-24 06:01:58.871	info	(4581) 0x00158d0003499a1b (addr 55984): WSDCGQ11LM - Xiaomi Aqara temperature, humidity and pressure sensor (EndDevice)
zigbee.0	2020-04-24 06:01:58.870	info	(4581) 0x84182600000fc87e (addr 41677): AB3257001NJ - OSRAM Smart+ plug (Router)
zigbee.0	2020-04-24 06:01:58.870	info	(4581) 0x00158d0002e99611 (addr 41990): WSDCGQ11LM - Xiaomi Aqara temperature, humidity and pressure sensor (EndDevice)
zigbee.0	2020-04-24 06:01:58.869	info	(4581) 0x00158d0002ea75fd (addr 22009): WSDCGQ11LM - Xiaomi Aqara temperature, humidity and pressure sensor (EndDevice)
zigbee.0	2020-04-24 06:01:58.868	info	(4581) 0x00158d000309a256 (addr 12940): WSDCGQ11LM - Xiaomi Aqara temperature, humidity and pressure sensor (EndDevice)
zigbee.0	2020-04-24 06:01:58.868	info	(4581) 0x00158d00036d347a (addr 54068): WSDCGQ11LM - Xiaomi Aqara temperature, humidity and pressure sensor (EndDevice)
zigbee.0	2020-04-24 06:01:58.867	info	(4581) 0x00158d0003499ad7 (addr 52718): WSDCGQ11LM - Xiaomi Aqara temperature, humidity and pressure sensor (EndDevice)
zigbee.0	2020-04-24 06:01:58.864	info	(4581) Currently 7 devices are joined:
zigbee.0	2020-04-24 06:01:58.860	info	(4581) --> transmitPower : normal
zigbee.0	2020-04-24 06:01:58.854	info	(4581) Coordinator firmware version: {"type":"zStack30x","meta":{"transportrev":2,"product":2,"majorrel":2,"minorrel":7,"maintrel":2,"revision":20200327}}
zigbee.0	2020-04-24 06:01:57.645	info	(4581) Starting Zigbee...
zigbee.0	2020-04-24 06:01:57.631	info	(4581) starting. Version 1.1.1 in /opt/iobroker/node_modules/iobroker.zigbee, node: v12.16.2, js-controller: 3.0.18
zigbee.0	2020-04-24 06:01:53.330	error	at stop (/opt/iobroker/node_modules/iobroker.js-controller/lib/adapter.js:8189:22)
zigbee.0	2020-04-24 06:01:53.330	error	at Zigbee.emit (events.js:310:20)
zigbee.0	2020-04-24 06:01:53.330	error	at Zigbee.onUnload (/opt/iobroker/node_modules/iobroker.zigbee/main.js:320:41)
zigbee.0	2020-04-24 06:01:53.330	error	at ZigbeeController.stop (/opt/iobroker/node_modules/iobroker.zigbee/lib/zigbeecontroller.js:303:20)
zigbee.0	2020-04-24 06:01:53.330	error	at ZigbeeController.callExtensionMethod (/opt/iobroker/node_modules/iobroker.zigbee/lib/zigbeecontroller.js:186:42)
zigbee.0	2020-04-24 06:01:53.330	error	at DeviceAvailability.stop (/opt/iobroker/node_modules/iobroker.zigbee/lib/zbDeviceAvailability.js:123:43)
zigbee.0	2020-04-24 06:01:53.330	error	at ZigbeeController.getClients (/opt/iobroker/node_modules/iobroker.zigbee/lib/zigbeecontroller.js:200:49)
zigbee.0	2020-04-24 06:01:53.330	error	at Controller.getDevices (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/controller.js:223:31)
zigbee.0	2020-04-24 06:01:53.330	error	at Function.all (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/model/device.js:220:16)
zigbee.0	2020-04-24 06:01:53.330	error	at Function.loadFromDatabaseIfNecessary (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/model/device.js:200:55)
zigbee.0	2020-04-24 06:01:53.330	error	(4531) TypeError: Cannot read property 'getEntries' of null
zigbee.0	2020-04-24 06:01:53.330	error	(4531) uncaught exception: Cannot read property 'getEntries' of null
zigbee.0	2020-04-24 06:01:53.329	info	(4531) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
zigbee.0	2020-04-24 06:01:53.329	info	(4531) terminating
zigbee.0	2020-04-24 06:01:53.329	error	at processTicksAndRejections (internal/process/task_queues.js:97:5))
zigbee.0	2020-04-24 06:01:53.329	error	at ZigbeeController.stop (/opt/iobroker/node_modules/iobroker.zigbee/lib/zigbeecontroller.js:307:33)
zigbee.0	2020-04-24 06:01:53.329	error	at Controller.stop (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/controller.js:174:16)
zigbee.0	2020-04-24 06:01:53.329	error	at __awaiter (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/controller.js:4:12)
zigbee.0	2020-04-24 06:01:53.329	error	at new Promise (<anonymous>)
zigbee.0	2020-04-24 06:01:53.329	error	at /opt/iobroker/node_modules/zigbee-herdsman/dist/controller/controller.js:8:71
zigbee.0	2020-04-24 06:01:53.329	error	at Generator.next (<anonymous>)
zigbee.0	2020-04-24 06:01:53.329	error	at Controller.<anonymous> (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/controller.js:178:49)
zigbee.0	2020-04-24 06:01:53.329	error	at Function.all (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/model/group.js:76:15)
zigbee.0	2020-04-24 06:01:53.329	error	at Function.loadFromDatabaseIfNecessary (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/model/group.js:64:55)
zigbee.0	2020-04-24 06:01:53.329	error	(4531) Failed to stop zigbee (TypeError: Cannot read property 'getEntries' of null
zigbee.0	2020-04-24 06:01:53.328	info	(4531) Zigbee: disabling joining new devices.
zigbee.0	2020-04-24 06:01:53.327	info	(4531) cleaned everything up...
zigbee.0	2020-04-24 06:01:53.326	info	(4531) Got terminate signal TERMINATE_YOURSELF
zigbee.0	2020-04-24 06:01:51.594	error	at /opt/iobroker/node_modules/@serialport/stream/lib/index.js:242:12
zigbee.0	2020-04-24 06:01:51.594	error	at SerialPort._error (/opt/iobroker/node_modules/@serialport/stream/lib/index.js:198:14)
zigbee.0	2020-04-24 06:01:51.594	error	at SerialPort.<anonymous> (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:111:49)
zigbee.0	2020-04-24 06:01:51.594	error	at __awaiter (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:4:12)
zigbee.0	2020-04-24 06:01:51.594	error	at new Promise (<anonymous>)
zigbee.0	2020-04-24 06:01:51.594	error	at /opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:8:71
zigbee.0	2020-04-24 06:01:51.594	error	at Generator.next (<anonymous>)
zigbee.0	2020-04-24 06:01:51.594	error	at Znp.<anonymous> (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:113:32)
zigbee.0	2020-04-24 06:01:51.594	error	(4531) Error: Error while opening serialport 'Error: Error Resource temporarily unavailable Cannot lock port'
zigbee.0	2020-04-24 06:01:51.593	error	(4531) Failed to start Zigbee
zigbee.0	2020-04-24 06:01:51.533	info	(4531) Starting Zigbee...
zigbee.0	2020-04-24 06:01:51.533	info	(4531) Try to reconnect. 1 attempts left
zigbee.0	2020-04-24 06:01:41.531	error	at rejected (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/adapter/zStackAdapter.js:6:65)
zigbee.0	2020-04-24 06:01:41.531	error	at Generator.throw (<anonymous>)
zigbee.0	2020-04-24 06:01:41.531	error	at ZStackAdapter.<anonymous> (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/adapter/zStackAdapter.js:71:23)
zigbee.0	2020-04-24 06:01:41.531	error	(4531) Error: Failed to connect to the adapter (Error: SRSP - SYS - ping after 6000ms)
zigbee.0	2020-04-24 06:01:41.531	error	(4531) Failed to start Zigbee
zigbee.0	2020-04-24 06:01:34.425	info	(4531) Starting Zigbee...
zigbee.0	2020-04-24 06:01:34.414	info	(4531) starting. Version 1.1.1 in /opt/iobroker/node_modules/iobroker.zigbee, node: v12.16.2, js-controller: 3.0.18

[Kueppert]

Hallo zusammen,
ich bin auf JS-Controller 3.0.20 und habe erst seit kurzem (2 Tage?) folgende Fehlermeldungen im LOG :(

zigbee.0	2020-04-29 08:13:57.448	error	(22760) Error: Timeout - 42681 - 3 - 5 - 0 - 1 after 10000ms at Timeout._onTimeout (/opt/iobroker/node_modules/iobroker.zigbee/node_modules/zigbee-herdsman/dist/utils/waitress.js:44:24) at lis
zigbee.0	2020-04-29 08:13:57.447	error	(22760) uncaught exception: Timeout - 42681 - 3 - 5 - 0 - 1 after 10000ms
zigbee.0	2020-04-29 08:08:06.446	error	at processTimers (internal/timers.js:492:7)
zigbee.0	2020-04-29 08:08:06.446	error	at listOnTimeout (internal/timers.js:549:17)
zigbee.0	2020-04-29 08:08:06.446	error	at Timeout._onTimeout (/opt/iobroker/node_modules/iobroker.zigbee/node_modules/zigbee-herdsman/dist/utils/waitress.js:44:24)
zigbee.0	2020-04-29 08:08:06.446	error	(10870) Error: Timeout - 1681 - 3 - 11 - 0 - 1 after 10000ms
zigbee.0	2020-04-29 08:08:06.445	error	(10870) uncaught exception: Timeout - 1681 - 3 - 11 - 0 - 1 after 10000ms
zigbee.0	2020-04-29 07:57:16.183	error	at rejected (/opt/iobroker/node_modules/iobroker.zigbee/node_modules/zigbee-herdsman/dist/controller/model/endpoint.js:6:65)
zigbee.0	2020-04-29 07:57:16.183	error	at Generator.throw (<anonymous>)
zigbee.0	2020-04-29 07:57:16.183	error	at Endpoint.<anonymous> (/opt/iobroker/node_modules/iobroker.zigbee/node_modules/zigbee-herdsman/dist/controller/model/endpoint.js:349:23)
zigbee.0	2020-04-29 07:57:16.183	error	(7451) Error on send command to 0x8418260000dad4e7. Error: Error: Command 0x8418260000dad4e7/3 genLevelCtrl.moveToLevelWithOnOff({"level":38,"transtime":0}, {"timeout":10000,"manufacturerCode":null,"
zigbee.0	2020-04-29 07:57:16.070	error	at rejected (/opt/iobroker/node_modules/iobroker.zigbee/node_modules/zigbee-herdsman/dist/controller/model/endpoint.js:6:65)
zigbee.0	2020-04-29 07:57:16.070	error	at Generator.throw (<anonymous>)
zigbee.0	2020-04-29 07:57:16.070	error	at Endpoint.<anonymous> (/opt/iobroker/node_modules/iobroker.zigbee/node_modules/zigbee-herdsman/dist/controller/model/endpoint.js:349:23)
zigbee.0	2020-04-29 07:57:16.070	error	(7451) Error on send command to 0x8418260000000712. Error: Error: Command 0x8418260000000712/3 genLevelCtrl.moveToLevelWithOnOff({"level":38,"transtime":0}, {"timeout":10000,"manufacturerCode":null,"
zigbee.0	2020-04-29 07:57:15.863	error	at processTimers (internal/timers.js:492:7)
zigbee.0	2020-04-29 07:57:15.863	error	at listOnTimeout (internal/timers.js:549:17)
zigbee.0	2020-04-29 07:57:15.863	error	at Timeout._onTimeout (/opt/iobroker/node_modules/iobroker.zigbee/node_modules/zigbee-herdsman/dist/utils/waitress.js:44:24)
zigbee.0	2020-04-29 07:57:15.863	error	(7451) Error: Timeout - 30525 - 3 - 3 - 8 - 11 after 10000ms
zigbee.0	2020-04-29 07:57:15.862	error	(7451) uncaught exception: Timeout - 30525 - 3 - 3 - 8 - 11 after 10000ms
zigbee.0	2020-04-29 07:57:15.783	error	at processTimers (internal/timers.js:492:7)
zigbee.0	2020-04-29 07:57:15.783	error	at listOnTimeout (internal/timers.js:549:17)
zigbee.0	2020-04-29 07:57:15.783	error	at Timeout._onTimeout (/opt/iobroker/node_modules/iobroker.zigbee/node_modules/zigbee-herdsman/dist/utils/waitress.js:44:24)
zigbee.0	2020-04-29 07:57:15.783	error	(7451) Error: Timeout - 1681 - 3 - 2 - 8 - 11 after 10000ms
zigbee.0	2020-04-29 07:57:15.782	error	(7451) uncaught exception: Timeout - 1681 - 3 - 2 - 8 - 11 after 10000ms

Vielleicht ist auf die genutzte Firmware von Interesse:

zigbee.0	2020-04-29 08:14:31.999	info	(29192) Coordinator firmware version: {"type":"zStack30x","meta":{"transportrev":2,"product":2,"majorrel":2,"minorrel":7,"maintrel":2,"revision":20190523}}

Die sehen anders aus als die bisher gelieferten Logs. Jmd eine Idee, was ich machen muss? Ein Rebuild für den Adapter hab ich bereits gemacht...
Danke euch und vG, Thorsten

[Asgothian]

@Kueppert
Eine kurze Frage:

Funktioniert der Adapter trotz der Meldungen oder ist der Adapter gelb ?

A.

[Kueppert]

@Asgothian der Adapter war trotzdem grün. Ich hab aus Gewohnheit jetzt mal den Stick wieder gezogen im laufenden Betrieb und wieder dran gesteckt. Gerade ist erst mal wieder Ruhe im Karton. Ist mir nur aufgefallen, weil meine Lampen nicht mehr geschaltet haben...Netzwerk baut sich ja nach jedem Restart vom Adapter neu auf.
Danke dir und vG, Thorsten

[Asgothian]

@Kueppert Nach den Meldungen gehe ich davon aus das es einen Timeout beim Senden oder Empfangen gibt. Insgesamt ist das Thema "timeout" und die daraus resultierenden Meldungen im Zigbee-Adapter noch ein weites Feld, es sind nicht alle Eventualitäten abgefangen, so das Fehlermeldungen ggf. bis zum ioBroker-Log durchlaufen obwohl sie eigentlich als behandelt intern abgefangen gehören.

Solange wie diese Meldungen die Folgenden Randbedingungen erfüllen würde ich mir erst einmal wenig sorgen machen.

• Der Adapter bleibt grün
• Es gibt keine offensichtlichen Funktionsausfälle (Lampen die nicht schalten, Sensoren die nicht Melden)
• Stehen im Zusammenhang mit "Timeout after 10000 ms" und "Error on send command to"

In diesem Zusammenhang gehe ich davon aus das ein Endgerät einen Befehl des Coordinators nicht quittiert hat, bzw. das die Quittierung am Coordinator nicht angekommen ist.

A.

[ldittmar]

Ich habe genau den gleichen Fehler:

zigbee.0	2020-04-29 16:06:40.370	error	(4812) 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/zn
zigbee.0	2020-04-29 16:06:40.369	error	(4812) Failed to start Zigbee
zigbee.0	2020-04-29 16:06:40.192	info	(4812) Starting Zigbee...
zigbee.0	2020-04-29 16:06:40.190	info	(4812) Try to reconnect. 1 attempts left
zigbee.0	2020-04-29 16:06:30.187	error	(4812) Error: AREQ - ZDO - activeEpRsp after 10000ms at Timeout.object.timer.setTimeout [as _onTimeout] (/opt/iobroker/node_modules/zigbee-herdsman/dist/utils/waitress.js:44:24) at ontimeout (
zigbee.0	2020-04-29 16:06:30.185	error	(4812) Failed to start Zigbee
zigbee.0	2020-04-29 16:06:18.676	info	(4812) Starting Zigbee...
zigbee.0	2020-04-29 16:06:18.641	info	(4812) starting. Version 1.1.1 in /opt/iobroker/node_modules/iobroker.zigbee, node: v10.18.1, js-controller: 3.0.20
zigbee.0	2020-04-29 16:05:45.850	info	(4564) Terminated (NO_ERROR): Without reason
zigbee.0	2020-04-29 16:05:45.848	info	(4564) terminating
zigbee.0	2020-04-29 16:05:45.341	info	(4564) Zigbee: disabling joining new devices.
zigbee.0	2020-04-29 16:05:45.338	info	(4564) cleaned everything up...
zigbee.0	2020-04-29 16:05:45.334	error	at fulfilled (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:5:58)
zigbee.0	2020-04-29 16:05:45.334	error	at Generator.next (<anonymous>)
zigbee.0	2020-04-29 16:05:45.334	error	at Znp.<anonymous> (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:246:27)
zigbee.0	2020-04-29 16:05:45.334	error	(4564) Error: SREQ '--> AF - interPanCtl - {"cmd":1,"data":[18]}' failed with status '186' (expected '0')
zigbee.0	2020-04-29 16:05:45.334	error	(4564) uncaught exception: SREQ '--> AF - interPanCtl - {"cmd":1,"data":[18]}' failed with status '186' (expected '0')
zigbee.0	2020-04-29 16:05:45.324	info	(4564) Starting interview of '0x00158d00045c13ef'
zigbee.0	2020-04-29 16:05:31.403	info	(4564) Zigbee: allowing new devices to join.

ich wollte ein neuen Gerät anlernen und dann ist es abgestürzt. Ich kann also keine neue Geräte anlernen :-(

Stick raus, dann wieder rein und dann kann der Adapter neu gestartet werden. Nur das Anlernen ist nicht mehr möglich....

---

Model: Intel(R) Celeron(R) CPU J3455 @ 1.50GHz, RAM: 7.64 GB, Node.js: v10.18.1, NPM: 6.13.4, Architecture: x64, Distribution: Debian GNU/Linux, Platform: linux, JS-Controller (1): 3.0.20, Admin: 4.1.1, Zigbee: 1.1.1

[craysee]

Hallo,

hab heute das gleiche Problem festgestellt. Wollte ein neues Gerät anlernen, und dann ging es los wie oben genannt. Habe auch den Stick entfernt, wieder ran und dann den Adapter wieder gestartet. Jetzt läuft es erstmal wieder. Einen weiteren Anlernversuch habe ich dann erstmal unterlassen. (Zigbee 1.1.1)

Gruß

Cray