ioBroker / ioBroker.zigbee

Zigbee communcation with Hue, Xiaomi, Lighttify... via TI CC2xxx USB stick
MIT License
315 stars 190 forks source link

Adapter Neustart nach Datenpunkt-Änderung Tuya Präsenzsensor ZG-204ZM #2211

Closed michi2005 closed 2 weeks ago

michi2005 commented 1 month ago

Lieber Dev,

ich habe die 1.10.9 heruntergeladen.

Sobald ich nun einen der Datenpunkte (Sensitivität etc.) des Tuya Präsenzsensors ZG-204ZM ändere, stürzt der ganze Zigbee Adapter ab:

2024-09-23 17:14:32.580 - error: zigbee.0 (3699) Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch().
2024-09-23 17:14:32.580 - error: zigbee.0 (3699) unhandled promise rejection: Cannot read properties of undefined (reading 'includes')
2024-09-23 17:14:32.581 - error: zigbee.0 (3699) TypeError: Cannot read properties of undefined (reading 'includes')
at /opt/iobroker/node_modules/iobroker.zigbee/main.js:694:78
at Array.find ()
at /opt/iobroker/node_modules/iobroker.zigbee/main.js:694:56
at Array.forEach ()
at Zigbee.publishFromState (/opt/iobroker/node_modules/iobroker.zigbee/main.js:634:23)
2024-09-23 17:14:32.581 - error: zigbee.0 (3699) Cannot read properties of undefined (reading 'includes')
2024-09-23 17:14:32.586 - info: zigbee.0 (3699) cleaned everything up...
2024-09-23 17:14:32.591 - info: zigbee.0 (3699) Zigbee: disabling joining new devices.
2024-09-23 17:14:33.089 - info: zigbee.0 (3699) terminating
2024-09-23 17:14:33.091 - warn: zigbee.0 (3699) Terminated (UNCAUGHT_EXCEPTION): Without reason
{1}

Danke im Voraus für die Lösung. Gruß Michi

Mod Edit - multiline code tags

asgothian commented 1 month ago

please test:

michi2005 commented 1 month ago

In the stable adapter it worked. There were 2 data points less. No adjustments for sensitivity and distance of the movement sensor. Generally it was supported in the stable adapter. Only the picture was missing and the 2 mentioned data points.

It's the presence sensor from the Tuya ZG-204ZM.

https://www.zigbee2mqtt.io/devices/ZG-204ZM.html#tuya-zg-204zm

asgothian commented 1 month ago

A.

michi2005 commented 1 month ago

No, adapter will crash no matter which data points I update- also the old ones that worked with 1.3

image
asgothian commented 1 month ago

Please perform a state cleanup from the adapter (this icon). It is possible that the ioBroker still has old DP's which are no longer supported. Screenshot 2024-09-24 at 22 19 38

michi2005 commented 1 month ago

I did the clean up. Log shows no deletions. Error remains.

asgothian commented 1 month ago

Please test by installing from my test branch at

https://github.com/asgothian/ioBroker.zigbee/tarball/MapTest

and test again. Please also post any error messages received in case the adapter no longer dies.

A.

michi2005 commented 1 month ago

Dear asgothian,

thanks for this try- but no success- did also a state cleanup:


2024-09-25 12:54:40.227 - info: zigbee.0 (112034) debug devices set to []
--
2024-09-25 12:54:41.077 - info: zigbee.0 (112034) Method "deleteDevice" is deprecated and will be removed in js-controller 7, use "delObject" instead
2024-09-25 12:54:41.080 - info: zigbee.0 (112034) Method "deleteDevice" is deprecated and will be removed in js-controller 7, use "delObject" instead
2024-09-25 12:54:49.409 - info: admin.0 (84884) ==> Connected system.user.admin from ::ffff:192.168.188.74
2024-09-25 12:54:49.733 - info: zigbee.0 (112034) List of port: [{"path":"/dev/ttyUSB0","manufacturer":"Silicon Labs","serialNumber":"0001","pnpId":"usb-Silicon_Labs_Sonoff_Zigbee_3.0_USB_Dongle_Plus_0001-if00-port0","vendorId":"10c4","productId":"ea60"},{"path":"/dev/ttyS0"}]
2024-09-25 12:54:52.912 - info: zigbee.0 (112034) State cleanup with {"force":false}
2024-09-25 12:55:02.252 - info: admin.0 (84884) <== Disconnect system.user.admin from ::ffff:192.168.188.74
2024-09-25 12:55:14.634 - error: zigbee.0 (112034) Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch().
2024-09-25 12:55:14.635 - error: zigbee.0 (112034) unhandled promise rejection: Cannot read properties of undefined (reading 'includes')
2024-09-25 12:55:14.636 - error: zigbee.0 (112034) TypeError: Cannot read properties of undefined (reading 'includes')
at /opt/iobroker/node_modules/iobroker.zigbee/main.js:700:78
at Array.find ()
at /opt/iobroker/node_modules/iobroker.zigbee/main.js:700:56
at Array.forEach ()
at Zigbee.publishFromState (/opt/iobroker/node_modules/iobroker.zigbee/main.js:640:23)
2024-09-25 12:55:14.636 - error: zigbee.0 (112034) Cannot read properties of undefined (reading 'includes')
2024-09-25 12:55:14.640 - info: zigbee.0 (112034) cleaned everything up...
2024-09-25 12:55:14.644 - info: zigbee.0 (112034) Zigbee: disabling joining new devices.
2024-09-25 12:55:15.144 - info: zigbee.0 (112034) terminating
2024-09-25 12:55:15.146 - warn: zigbee.0 (112034) Terminated (UNCAUGHT_EXCEPTION): Without reason
2024-09-25 12:55:15.848 - error: host.raspberrypi instance system.adapter.zigbee.0 terminated with code 6 (UNCAUGHT_EXCEPTION)
2024-09-25 12:55:15.849 - info: host.raspberrypi Restart adapter system.adapter.zigbee.0 because enabled
2024-09-25 12:55:46.691 - info: host.raspberrypi instance system.adapter.zigbee.0 in version "1.10.9" (non-npm: asgothian/ioBroker.zigbee#MapTest) started with pid 112088
2024-09-25 12:55:52.486 - info: zigbee.0 (112088) starting. Version 1.10.9 (non-npm: asgothian/ioBroker.zigbee#MapTest) in /opt/iobroker/node_modules/iobroker.zigbee, node: v20.17.0, js-controller: 6.0.9
2024-09-25 12:55:52.597 - info: zigbee.0 (112088) delete old Backup files. keep only last 10
2024-09-25 12:55:52.601 - info: zigbee.0 (112088) Starting Zigbee npm ...
2024-09-25 12:55:52.993 - info: zigbee.0 (112088) Installed Version: asgothian/ioBroker.zigbee#MapTest
2024-09-25 12:55:53.988 - info: zigbee.0 (112088) Coordinator firmware version: {"type":"zStack3x0","meta":{"transportrev":2,"product":1,"majorrel":2,"minorrel":7,"maintrel":1,"revision":20240710}}
asgothian commented 1 month ago

Please repeat the test. I made another change trying to figure out where it fails.

michi2005 commented 1 month ago

So sorry to say- but no success:


2024-09-25 14:45:37.976 - info: zigbee.0 (112088) List of port: [{"path":"/dev/ttyUSB0","manufacturer":"Silicon Labs","serialNumber":"0001","pnpId":"usb-Silicon_Labs_Sonoff_Zigbee_3.0_USB_Dongle_Plus_0001-if00-port0","vendorId":"10c4","productId":"ea60"},{"path":"/dev/ttyS0"}]
2024-09-25 14:45:50.864 - info: zigbee.0 (112088) State cleanup with {"force":false}
2024-09-25 14:45:54.050 - info: admin.0 (84884) <== Disconnect system.user.admin from ::ffff:192.168.188.74
2024-09-25 14:45:55.719 - info: admin.0 (84884) <== Disconnect system.user.admin from ::ffff:192.168.188.74 admin
2024-09-25 14:45:55.720 - info: admin.0 (84884) <== Disconnect system.user.admin from ::ffff:192.168.188.74
2024-09-25 14:46:48.427 - error: zigbee.0 (112088) Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch().
2024-09-25 14:46:48.428 - error: zigbee.0 (112088) unhandled promise rejection: Cannot read properties of undefined (reading 'includes')
2024-09-25 14:46:48.428 - error: zigbee.0 (112088) TypeError: Cannot read properties of undefined (reading 'includes')
at /opt/iobroker/node_modules/iobroker.zigbee/main.js:700:78
at Array.find ()
at /opt/iobroker/node_modules/iobroker.zigbee/main.js:700:56
at Array.forEach ()
at Zigbee.publishFromState (/opt/iobroker/node_modules/iobroker.zigbee/main.js:640:23)
2024-09-25 14:46:48.428 - error: zigbee.0 (112088) Cannot read properties of undefined (reading 'includes')
2024-09-25 14:46:48.433 - info: zigbee.0 (112088) cleaned everything up...
2024-09-25 14:46:48.437 - info: zigbee.0 (112088) Zigbee: disabling joining new devices.
2024-09-25 14:46:48.945 - info: zigbee.0 (112088) terminating
2024-09-25 14:46:48.949 - warn: zigbee.0 (112088) Terminated (UNCAUGHT_EXCEPTION): Without reason
2024-09-25 14:46:49.661 - error: host.raspberrypi instance system.adapter.zigbee.0 terminated with code 6 (UNCAUGHT_EXCEPTION)
2024-09-25 14:46:49.662 - info: host.raspberrypi Restart adapter system.adapter.zigbee.0 because enabled
2024-09-25 14:47:20.600 - info: host.raspberrypi instance system.adapter.zigbee.0 in version "1.10.9" (non-npm: asgothian/ioBroker.zigbee#MapTest) started with pid 115529
asgothian commented 1 month ago

Please install again and try again. You can drop the state cleanup - I am not changing anything there. With the new version, you should be seeing a warning message in the log before the adapter crashes.

The crash is not addressed yet as I need to figure out what causes it before I can get there.

A.

michi2005 commented 1 month ago

The adapter won't crash anymore. This is the output, after changing 3 DPs.

2024-09-25 21:40:31.595 - error: zigbee.0 (126944) No converter available for 'ZG-204ZM' with key 'static_detection_distance'
--
2024-09-25 21:41:20.245 - error: zigbee.0 (126944) No converter available for 'ZG-204ZM' with key 'motion_detection_mode'
2024-09-25 21:41:50.019 - error: zigbee.0 (126944) No converter available for 'ZG-204ZM' with key 'motion_detection_sensitivity'
asgothian commented 1 month ago

did you get warning messages before that ? If so, please post

A.

michi2005 commented 1 month ago

No- nothing:

zigbee.0 | 2024-09-25 21:50:16.369 | info | List of port: [{"path":"/dev/ttyUSB0","manufacturer":"Silicon Labs","serialNumber":"0001","pnpId":"usb-Silicon_Labs_Sonoff_Zigbee_3.0_USB_Dongle_Plus_0001-if00-port0","vendorId":"10c4","productId":"ea60"},{"path":"/dev/ttyS0"}]
-- | -- | -- | --
zigbee.0 | 2024-09-25 21:41:50.019 | error | No converter available for 'ZG-204ZM' with key 'motion_detection_sensitivity'
zigbee.0 | 2024-09-25 21:41:20.245 | error | No converter available for 'ZG-204ZM' with key 'motion_detection_mode'
zigbee.0 | 2024-09-25 21:40:31.595 | error | No converter available for 'ZG-204ZM' with key 'static_detection_distance'
zigbee.0 | 2024-09-25 21:39:05.119 | info | List of port: [{"path":"/dev/ttyUSB0","manufacturer":"Silicon Labs","serialNumber":"0001","pnpId":"usb-Silicon_Labs_Sonoff_Zigbee_3.0_USB_Dongle_Plus_0001-if00-port0","vendorId":"10c4","productId":"ea60"},{"path":"/dev/ttyS0"}]
zigbee.0 | 2024-09-25 21:36:38.260 | warn | DeviceAvailability:Failed to ping 0xccccccfffe7df671 RF 263
asgothian commented 1 month ago

what happens if you try to edit a state on another device ?

michi2005 commented 1 month ago

the state will be written- no log entry...

asgothian commented 1 month ago

can you please check and post the lines 629 to 644 from the file /opt/iobroker/node-modules/iobroker.zigbee/main.js ?

michi2005 commented 1 month ago
if (!mappedModel) {
                this.log.debug(`No mapped model for ${model}`);
                return;
            }

            if (!mappedModel.toZigbee)
                {
                    this.log.error(`No toZigbee in mapped model for ${model}`);
                    return;
                }

            this.log.warn('Mapped Model.toZigbee is ' + JSON.stringify(mappedModel.toZigbee));

            stateList.forEach(async changedState => {
                const stateDesc = changedState.stateDesc;
                const value = changedState.value;
asgothian commented 1 month ago

please change the code

this.log.warn

to

this.log.error

and then restart the adapter.

A. (that is in the code you posted above, not anywhere else)

michi2005 commented 1 month ago

2024-09-25 22:48:50.088 - info: zigbee.0 (129374) Zigbee started
--
2024-09-25 22:48:50.366 - info: zigbee.0 (129374) debug devices set to []
2024-09-25 22:48:53.041 - info: zigbee.0 (129374) Method "deleteDevice" is deprecated and will be removed in js-controller 7, use "delObject" instead
2024-09-25 22:48:53.048 - info: zigbee.0 (129374) Method "deleteDevice" is deprecated and will be removed in js-controller 7, use "delObject" instead
2024-09-25 22:48:57.158 - error: zigbee.0 (129374) Mapped Model.toZigbee is [{},{"key":["scene_store"]},{"key":["scene_recall"]},{"key":["scene_add"]},{"key":["scene_remove"]},{"key":["scene_remove_all"]},{"key":["scene_rename"]},{"key":["read"]},{"key":["write"]},{"key":["command"]},{"key":["reset"]},{"key":["zclcommand"]}]
2024-09-25 22:48:57.159 - error: zigbee.0 (129374) No converter available for 'ZG-204ZM' with key 'motion_detection_sensitivity'
asgothian commented 1 month ago

ok.. now we are getting somewhere. but that has to wait til tomorrow

A.

michi2005 commented 1 month ago

No worries- thank you so much for your incredible effort! :)

asgothian commented 1 month ago

And on we go. Another test is set up. Please note: I expect you to get plenty of error messages like these:

2024-09-26 17:30:27.247  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["child_lock"]
2024-09-26 17:30:27.247  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["window_detection"]
2024-09-26 17:30:27.247  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["valve_detection"]
2024-09-26 17:30:27.248  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["current_heating_setpoint"]
2024-09-26 17:30:27.248  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["system_mode"]
2024-09-26 17:30:27.248  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["auto_lock"]
2024-09-26 17:30:27.248  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["local_temperature_calibration"]
2024-09-26 17:30:27.249  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["min_temperature"]
2024-09-26 17:30:27.249  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["max_temperature"]
2024-09-26 17:30:27.249  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["comfort_temperature"]
2024-09-26 17:30:27.249  - error: zigbee.0 (4079) Setting' converter to converter with key(s)'["comfort_temperature"]}
2024-09-26 17:30:27.250  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["eco_temperature"]
2024-09-26 17:30:27.250  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["force"]
2024-09-26 17:30:27.250  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["preset"]
2024-09-26 17:30:27.250  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["boost_time"]
2024-09-26 17:30:27.251  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["scene_store"]
2024-09-26 17:30:27.251  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["scene_recall"]
2024-09-26 17:30:27.251  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["scene_add"]
2024-09-26 17:30:27.251  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["scene_remove"]
2024-09-26 17:30:27.252  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["scene_remove_all"]
2024-09-26 17:30:27.252  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["scene_rename"]
2024-09-26 17:30:27.252  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["read"]
2024-09-26 17:30:27.252  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["write"]
2024-09-26 17:30:27.252  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["command"]
2024-09-26 17:30:27.253  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["reset"]
2024-09-26 17:30:27.253  - error: zigbee.0 (4079) Type of toZigbee is 'object', Contains key ["zclcommand"]

Important is to see a line which sets the converter to something, possibly another line which overrides it.

It is my hope that the adapter no longer dies either.

A. p.s. the messages are for me - they will get removed before this goes live

michi2005 commented 1 month ago

Indeed there is a lot going on :)

2024-09-26 18:20:41.189 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["state","brightness","brightness_percent","on_time"]
2024-09-26 18:20:41.190 - error: zigbee.0 (160053) Setting' converter to converter with key(s)'["state","brightness","brightness_percent","on_time"]}
2024-09-26 18:20:41.191 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["color","color_temp","color_temp_percent"]
2024-09-26 18:20:41.191 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["effect"]
2024-09-26 18:20:41.192 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["transition"]
2024-09-26 18:20:41.192 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["position","tilt"]
2024-09-26 18:20:41.192 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["occupied_heating_setpoint"]
2024-09-26 18:20:41.193 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["tint_scene"]
2024-09-26 18:20:41.194 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["brightness_move","brightness_move_onoff"]
2024-09-26 18:20:41.194 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["brightness_step","brightness_step_onoff"]
2024-09-26 18:20:41.195 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["color_temp_step"]
2024-09-26 18:20:41.195 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["colortemp_move","color_temp_move"]
2024-09-26 18:20:41.196 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["hue_move","saturation_move"]
2024-09-26 18:20:41.196 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["hue_step","saturation_step"]
2024-09-26 18:20:45.503 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key false
2024-09-26 18:20:45.504 - error: zigbee.0 (160053) setting converter to keyless converter
2024-09-26 18:20:45.504 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["scene_store"]
2024-09-26 18:20:45.504 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["scene_recall"]
2024-09-26 18:20:45.504 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["scene_add"]
2024-09-26 18:20:45.505 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["scene_remove"]
2024-09-26 18:20:45.505 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["scene_remove_all"]
2024-09-26 18:20:45.505 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["scene_rename"]
2024-09-26 18:20:45.505 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["read"]
2024-09-26 18:20:45.505 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["write"]
2024-09-26 18:20:45.506 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["command"]
2024-09-26 18:20:45.506 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["reset"]
2024-09-26 18:20:45.506 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["zclcommand"]
2024-09-26 18:20:48.205 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["state","brightness","brightness_percent","on_time"]
2024-09-26 18:20:48.205 - error: zigbee.0 (160053) Setting' converter to converter with key(s)'["state","brightness","brightness_percent","on_time"]}
2024-09-26 18:20:48.205 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["color","color_temp","color_temp_percent"]
2024-09-26 18:20:48.206 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["effect"]
2024-09-26 18:20:48.206 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["transition"]
2024-09-26 18:20:48.206 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["position","tilt"]
2024-09-26 18:20:48.207 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["occupied_heating_setpoint"]
2024-09-26 18:20:48.207 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["tint_scene"]
2024-09-26 18:20:48.207 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["brightness_move","brightness_move_onoff"]
2024-09-26 18:20:48.208 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["brightness_step","brightness_step_onoff"]
2024-09-26 18:20:48.208 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["color_temp_step"]
2024-09-26 18:20:48.208 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["colortemp_move","color_temp_move"]
2024-09-26 18:20:48.208 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["hue_move","saturation_move"]
2024-09-26 18:20:48.208 - error: zigbee.0 (160053) Type of toZigbee is 'object', Contains key ["hue_step","saturation_step"]
asgothian commented 1 month ago

any crashes or other odd things like devices not working ?

michi2005 commented 1 month ago

It works like a charm.... THANK YOU SO MUCH :)

asgothian commented 1 month ago

Ok. I’ll PR this into the main tree tomorrow

you can „get rid“ of the messages by changing the relevant this.log.error to this.log.debug around line 650 in main.js

A.

asgothian commented 1 month ago

change of plan. Would you be willing to test one more thing ? I pushed the required libraries for the Zigbee-herdsman and zigbee-herdsman-converters to the latest versions. As such there is a risk that it won't run on all versions of nodeJS. I tested it on node 18.18, but don't currently have test systems for lower or higher nodeJS versions.

If so, you can install again from the same link. It should give you the 1.10.10 version

michi2005 commented 1 month ago

At start is is all OK:

2024-09-28 12:16:16.912 - info: zigbee.0 (6038) starting. Version 1.10.10 (non-npm: asgothian/ioBroker.zigbee#MapTest) in /opt/iobroker/node_modules/iobroker.zigbee, node: v20.17.0, js-controller: 6.0.9
--
2024-09-28 12:16:17.018 - info: zigbee.0 (6038) delete old Backup files. keep only last 10
2024-09-28 12:16:17.022 - info: zigbee.0 (6038) Starting Zigbee npm ...
2024-09-28 12:16:17.495 - info: zigbee.0 (6038) Installed Version: asgothian/ioBroker.zigbee#MapTest
2024-09-28 12:16:18.120 - info: zigbee.0 (6038) Coordinator firmware version: {"type":"zStack3x0","meta":{"transportrev":2,"product":1,"majorrel":2,"minorrel":7,"maintrel":1,"revision":20240710}}
2024-09-28 12:16:18.122 - info: zigbee.0 (6038) Unable to disable LED, unsupported function.
2024-09-28 12:16:18.123 - info: zigbee.0 (6038) --> transmitPower : high+
2024-09-28 12:16:18.138 - info: zigbee.0 (6038) Currently 35 devices are joined:

Later when I do e.g. a firmware scan:


2024-09-28 12:26:40.565 - info: zigbee.0 (6314) Failed to check if update available for '0x54ef4410005aab80' Device didn't respond to OTA request
--
2024-09-28 12:26:40.599 - info: zigbee.0 (6314) Failed to check if update available for '0xccccccfffee584df' Device didn't respond to OTA request
2024-09-28 12:26:40.612 - info: zigbee.0 (6314) Failed to check if update available for '0x54ef4410007725ca' Device didn't respond to OTA request
2024-09-28 12:26:40.616 - info: zigbee.0 (6314) Failed to check if update available for '0x6c5cb1fffe1d3bc4' Device didn't respond to OTA request
2024-09-28 12:26:40.622 - info: zigbee.0 (6314) Failed to check if update available for '0x6c5cb1fffe1d3b9e' Device didn't respond to OTA request
2024-09-28 12:26:40.660 - error: zigbee.0 (6314) Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch().
2024-09-28 12:26:40.662 - error: zigbee.0 (6314) unhandled promise rejection: Timeout - 8564 - 1 - null - 25 - 1 after 60000ms
2024-09-28 12:26:40.664 - error: zigbee.0 (6314) Error: Timeout - 8564 - 1 - null - 25 - 1 after 60000ms
at Object.start (/opt/iobroker/node_modules/zigbee-herdsman/dist/utils/waitress.js:40:23)
at ZStackAdapter.waitFor (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/adapter/zStackAdapter.js:706:57)
at Endpoint.waitForCommand (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/model/endpoint.js:521:49)
at requestOTA (/opt/iobroker/node_modules/zigbee-herdsman-converters/lib/ota/common.js:325:44)
at Object.isUpdateAvailable (/opt/iobroker/node_modules/zigbee-herdsman-converters/lib/ota/common.js:402:35)
at Object.isUpdateAvailable (/opt/iobroker/node_modules/zigbee-herdsman-converters/lib/ota/tradfri.js:60:25)
at Ota.checkOtaAvail (/opt/iobroker/node_modules/iobroker.zigbee/lib/ota.js:97:59)
2024-09-28 12:26:40.664 - error: zigbee.0 (6314) Timeout - 8564 - 1 - null - 25 - 1 after 60000ms
2024-09-28 12:26:40.669 - info: zigbee.0 (6314) Failed to check if update available for '0xd87a3bfffe011806' Device didn't respond to OTA request
2024-09-28 12:26:40.769 - info: zigbee.0 (6314) Failed to check if update available for '0x54ef44100056d381' Device didn't respond to OTA request
2024-09-28 12:26:41.726 - info: zigbee.0 (6314) cleaned everything up...
2024-09-28 12:26:41.767 - info: zigbee.0 (6314) Zigbee: disabling joining new devices.
2024-09-28 12:26:42.241 - info: zigbee.0 (6314) terminating
2024-09-28 12:26:42.243 - warn: zigbee.0 (6314) Terminated (UNCAUGHT_EXCEPTION): Without reason
2024-09-28 12:26:42.804 - warn: zigbee.0 (6314) get state error: Connection is closed.
2024-09-28 12:26:42.805 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.805 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.806 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.806 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.806 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.807 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.808 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.808 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.808 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.809 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.809 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.810 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.810 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.810 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.810 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.811 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.811 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.811 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.812 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.812 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.813 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.813 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.813 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.814 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.814 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.814 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.815 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.815 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.815 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.816 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.816 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.816 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.817 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.817 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.817 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.818 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.818 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.819 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.819 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.819 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.820 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.820 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.820 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.821 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.821 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.821 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.822 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.822 - warn: zigbee.0 (6314) get state error: DB closed
2024-09-28 12:26:42.823 - warn: zigbee.0 (6314) redis mget of 466 keys, err: DB closed
2024-09-28 12:26:43.057 - warn: zigbee.0 (6314) Cannot get view: Connection is closed.
2024-09-28 12:26:43.061 - error: zigbee.0 (6314) getDevices error: Error: DB closed
at close (/opt/iobroker/node_modules/ioredis/built/redis/event_handler.js:184:25)
at Socket. (/opt/iobroker/node_modules/ioredis/built/redis/event_handler.js:151:20)
at Object.onceWrapper (node:events:634:26)
at Socket.emit (node:events:519:28)
at TCP. (node:net:339:12)
2024-09-28 12:26:43.291 - error: host.raspberrypi instance system.adapter.zigbee.0 terminated with code 6 (UNCAUGHT_EXCEPTION)
2024-09-28 12:26:43.292 - info: host.raspberrypi Restart adapter system.adapter.zigbee.0 because enabled
2024-09-28 12:26:43.292 - warn: host.raspberrypi Do not restart adapter system.adapter.zigbee.0 because restart loop detected
michi2005 commented 1 month ago

All other versions 1.10.9 and lower won't start anymore:

2024-09-28 13:01:51.730 - info: zigbee.0 (7806) Installed Version: iobroker.zigbee@1.10.9
--
2024-09-28 13:01:52.349 - error: zigbee.0 (7806) Starting zigbee-herdsman problem : "Attempt to access memory outside buffer bounds"
2024-09-28 13:01:52.350 - error: zigbee.0 (7806) Failed to start Zigbee
2024-09-28 13:01:52.351 - error: zigbee.0 (7806) Error herdsman start
2024-09-28 13:02:02.352 - info: zigbee.0 (7806) Try to reconnect. 1 attempts left
2024-09-28 13:02:02.354 - info: zigbee.0 (7806) Starting Zigbee npm ...
2024-09-28 13:02:02.399 - info: zigbee.0 (7806) Installed Version: iobroker.zigbee@1.10.9
2024-09-28 13:02:02.607 - error: zigbee.0 (7806) Starting zigbee-herdsman problem : "Error Resource temporarily unavailable Cannot lock port"
2024-09-28 13:02:02.609 - error: zigbee.0 (7806) Failed to start Zigbee
2024-09-28 13:02:02.611 - error: zigbee.0 (7806) Error herdsman start
asgothian commented 1 month ago

please check which versions of the Zigbee-herdsman and Zigbee-herdsman-converters are installed, and where.

also - try to restore an older version of the nvbackup.json file after installing the 1.10.9

another question - does the 1.10.10 start or does it generate the same error message ?

A.

michi2005 commented 1 month ago

Can you please explain me where I found the versions and how I can restore nvbackup.json in backitup?

1.10.10 starts without a problem, except those errors when I do a firmware scan

asgothian commented 1 month ago

Firmware scan ?

as to your question, there are two possible options: /opt/iobroker/node-modules /opt/iobroker/node-modules/iobroker.zigbee/node-modules

in those folders may be folders Zigbee-herdsman and Zigbee-herdsman-converters. In those you find a file called package.json which contains the version number. It is important to find out if the version number is downgraded when you install the 1.10.9 version

michi2005 commented 1 month ago

Firmware scan ?

When I do a "firmware ota scan".

It's in opt/iobroker/node_modules.

zigbee_herdsman: V2.1.1 zigbee_herdsman_converters: 20.18.0

asgothian commented 1 month ago

ok.. when you downgrade to the current stable version, which herdsman / converters versions do you get ?

michi2005 commented 1 month ago
`$ iobroker upgrade zigbee@1.10.9 --debug

Update zigbee from @1.10.9 to @1.10.9

Uninstall npm packet "iobroker.zigbee" for a clean re-installation

npm warn deprecated npmlog@4.1.2: This package is no longer supported.

npm warn deprecated are-we-there-yet@1.1.7: This package is no longer supported.

npm warn deprecated glob@7.2.3: Glob versions prior to v9 are no longer supported

npm warn deprecated gauge@2.7.4: This package is no longer supported.

removed 21 packages in 13s189 packages are looking for funding run `npm fund` for details

host.raspberrypi Adapter "system.adapter.zigbee.0" is stopped.

NPM version: 10.8.2Installing iobroker.zigbee@1.10.9... (System call)

npm error code ETARGET

npm error A complete log of this run can be found in: /home/iobroker/.npm/_logs/2024-09-28T11_33_10_958Z-debug-0.log

npm error code ETARGETnpm error notarget No matching version found for iobroker.zigbee@1.10.9.npm error notarget In most cases you or one of your dependencies are requestingnpm error notarget a package version that doesn't exist.npm error A complete log of this run can be found in: /home/iobroker/.npm/_logs/2024-09-28T11_33_10_958Z-debug-0.loghost.raspberrypi Cannot install iobroker.zigbee@1.10.9: 1

ERROR: Process exited with code 25`
asgothian commented 1 month ago

that's not the current stable version, but the one from the main GitHub. What do you get when installing the current stable version ? (1.10.3)

michi2005 commented 1 month ago

Installed 1.10.3 this is the log after start:


2024-09-28 13:41:07.254 - info: zigbee.0 (9390) Starting Zigbee npm ...
--
2024-09-28 13:41:07.660 - info: zigbee.0 (9390) Installed Version: iobroker.zigbee@1.10.3
2024-09-28 13:41:08.266 - error: zigbee.0 (9390) Starting zigbee-herdsman problem : "Attempt to access memory outside buffer bounds"
2024-09-28 13:41:08.267 - error: zigbee.0 (9390) Failed to start Zigbee
2024-09-28 13:41:08.268 - error: zigbee.0 (9390) Error herdsman start
2024-09-28 13:41:18.270 - info: zigbee.0 (9390) Try to reconnect. 1 attempts left
2024-09-28 13:41:18.272 - info: zigbee.0 (9390) Starting Zigbee npm ...
2024-09-28 13:41:18.315 - info: zigbee.0 (9390) Installed Version: iobroker.zigbee@1.10.3
2024-09-28 13:41:18.635 - error: zigbee.0 (9390) Starting zigbee-herdsman problem : "Error Resource temporarily unavailable Cannot lock port"
2024-09-28 13:41:18.638 - error: zigbee.0 (9390) Failed to start Zigbee
2024-09-28 13:41:18.640 - error: zigbee.0 (9390) Error herdsman start

herdsman: Version 0.41.2 herdsman-converter: 19.15.0

asgothian commented 1 month ago

ok.. do you still have a nvbackup.json from lets say 3 days ago ?

I assume that data in that file has been changed to cause this

michi2005 commented 1 month ago

The only thing that I have is "backitup"- How can I restore it out of this?

asgothian commented 1 month ago

you should be able to restore just the zigbee adapter from within backitup. alternatively, the file is a tgz, so you can unpack it manually and find the file

asgothian commented 1 month ago

once your system is up and running again with the stable version, I'd ask that you install the current GitHub version (1.10.9) from the standard GitHub via the admin interface. If that also works, I can roll back the changes with regards to the library requirements and update the 1.10 for a final test.

thank you for doing all these tests - I don't currently have access to a system to test this on.

A

asgothian commented 1 month ago

one additional question - what hardware do you use for the coordinator, and with which firmware ? I just asked another tester to run the firmware update scan, and it worked like a charm on their system (with the 1.10.10)

A.

michi2005 commented 1 month ago

I did the restore of the nvbackup.json backup, installed 1.10.3- works, after that installed 1.10.9 - works :)

michi2005 commented 1 month ago

one additional question - what hardware do you use for the coordinator, and with which firmware ? I just asked another tester to run the firmware update scan, and it worked like a charm on their system (with the 1.10.10)

A.

Sonoff 3.0 Dongle-P -> Newest firmware 20240710

Firmware scan now works without a crash

asgothian commented 1 month ago

adapter runs too ? which version currently ?

michi2005 commented 1 month ago

1.10.9 works and 1.10.10 finally as well :)

asgothian commented 1 month ago

with no issue with regards to firmware scan ?

michi2005 commented 1 month ago

Firmware scan works as well. I'm even doing a firmare update of a IKEA device now.

michi2005 commented 1 month ago

While updating this error occured:

2024-09-28 14:31:04.066 - info: zigbee.0 (10533) Update of '0x003c84fffeb24de2' at 3.98%, +- 143 minutes remaining
--
2024-09-28 14:31:36.023 - info: zigbee.0 (10533) Update of '0x003c84fffeb24de2' at 4.34%, +- 142 minutes remaining
2024-09-28 14:32:06.980 - info: zigbee.0 (10533) Update of '0x003c84fffeb24de2' at 4.69%, +- 142 minutes remaining
2024-09-28 14:32:18.075 - error: zigbee.0 (10533) Error 29 on send command to 2. Error: Error: Command 2 genOnOff.off({}) failed (Data request failed with error: 'undefined' (29))
at ZStackAdapter.dataRequestExtended (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/adapter/zStackAdapter.js:768:27)
at async /opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/adapter/zStackAdapter.js:496:13
at async Queue.execute (/opt/iobroker/node_modules/zigbee-herdsman/dist/utils/queue.js:28:20)
at async ZStackAdapter.sendZclFrameToGroup (/opt/iobroker/node_modules/zigbee-herdsman/dist/adapter/z-stack/adapter/zStackAdapter.js:494:16)
at async Group.command (/opt/iobroker/node_modules/zigbee-herdsman/dist/controller/model/group.js:218:13)
at async Object.convertSet (/opt/iobroker/node_modules/zigbee-herdsman-converters/converters/toZigbee.js:68:17)
at async Object.convertSet (/opt/iobroker/node_modules/zigbee-herdsman-converters/converters/toZigbee.js:1108:33)
at async /opt/iobroker/node_modules/iobroker.zigbee/main.js:782:36
2024-09-28 14:32:38.935 - info: zigbee.0 (10533) Update of '0x003c84fffeb24de2' at 5.05%, +- 141 minutes remaining
2024-09-28 14:33:10.897 - info: zigbee.0 (10533) Update of '0x003c84fffeb24de2' at 5.42%, +- 140 minutes remaining
2024-09-28 14:33:42.855 - info: zigbee.0 (10533) Update of '0x003c84fffeb24de2' at 5.78%, +- 140 minutes remaining
2024-09-28 14:33:59.182 - info: zigbee.0 (10533) Device '0x54ef441000a20238' announced itself
2024-09-28 14:34:14.810 - info: zigbee.0 (10533) Update of '0x003c84fffeb24de2' at 6.15%, +- 139 minutes remaining