NEWS
SOLVED Zigbee adapter nach upgrade gelb
-
@steimi
Die Fehlermeldung deutet darauf hin das die serielle Schnittstelle nicht geöffnet werden kann. Es ist also zu prüfen:- ist der Stick sauber an die vom weitergereicht
- hat der Nutzer iobroker schreib und leserechte auf den seriellen Port ?
A.
-
Sorry, hat sich wohlmöglich erledigt, zumindest ist er wieder grün.
Serielle Schnittstelle war das Problem.
Mit dem Befehl bin ich drauf gekommen und musste ttyACM0 wieder im Zigbee Adapter hinterlegen.
simon@debian-simon:~$ ls -la /dev/serial/by-id insgesamt 0 drwxr-xr-x 2 root root 60 Feb 7 07:02 . drwxr-xr-x 4 root root 80 Feb 7 07:02 .. lrwxrwxrwx 1 root root 13 Feb 7 07:02 usb-Texas_Instruments_TI_CC2531_USB_CDC__ _0X00124B000BE5ADB1-if00 -> ../../ttyACM0
-
@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.
-
@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.
-
Okay, wäre ein Versuch wert. Wie mache ich das?
-
@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 ,,,
-
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
-
Hallo zusammen,
ich bin auf JS-Controller 3.0.20 und habe erst seit kurzem (2 Tage?) folgende Fehlermeldungen im LOGzigbee.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 -
@Kueppert
Eine kurze Frage:Funktioniert der Adapter trotz der Meldungen oder ist der Adapter gelb ?
A.
-
@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 -
@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.
-
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
-
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