Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

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

Open
michi2005 opened this issue Sep 23, 2024 · 53 comments
Open

Comments

@michi2005
Copy link

michi2005 commented Sep 23, 2024

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
Copy link
Collaborator

please test:

  • does this also happen with the stable adapter ?
  • which device (link, etc) is affected ? Is it supported in the stable adapter ?
    A.

@michi2005
Copy link
Author

michi2005 commented Sep 23, 2024

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
Copy link
Collaborator

  • Are the crashes limited to changing the new 2 datapoints or do they also occur when the previous datapoints are changed ?
  • which datapoints are triggering the crash exactly ?

A.

@michi2005
Copy link
Author

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

image

@asgothian
Copy link
Collaborator

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
Copy link
Author

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

@asgothian
Copy link
Collaborator

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
Copy link
Author

michi2005 commented Sep 25, 2024

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
Copy link
Collaborator

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

@michi2005
Copy link
Author

michi2005 commented Sep 25, 2024

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
Copy link
Collaborator

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
Copy link
Author

michi2005 commented Sep 25, 2024

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
Copy link
Collaborator

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

A.

@michi2005
Copy link
Author

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
Copy link
Collaborator

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

@michi2005
Copy link
Author

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

@asgothian
Copy link
Collaborator

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

@michi2005
Copy link
Author

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
Copy link
Collaborator

asgothian commented Sep 25, 2024

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
Copy link
Author


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
Copy link
Collaborator

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

A.

@michi2005
Copy link
Author

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

@asgothian
Copy link
Collaborator

asgothian commented Sep 26, 2024

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
Copy link
Author

michi2005 commented Sep 26, 2024

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
Copy link
Collaborator

any crashes or other odd things like devices not working ?

@michi2005
Copy link
Author

michi2005 commented Sep 26, 2024

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

@asgothian
Copy link
Collaborator

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
Copy link
Collaborator

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
Copy link
Author

michi2005 commented Sep 28, 2024

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
Copy link
Author

michi2005 commented Sep 28, 2024

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: [email protected]
--
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: [email protected]
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
Copy link
Collaborator

asgothian commented Sep 28, 2024

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
Copy link
Author

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
Copy link
Collaborator

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
Copy link
Author

michi2005 commented Sep 28, 2024

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
Copy link
Collaborator

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

@michi2005
Copy link
Author

michi2005 commented Sep 28, 2024

`$ iobroker upgrade [email protected] --debug

Update zigbee from @1.10.9 to @1.10.9

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

npm warn deprecated [email protected]: This package is no longer supported.

npm warn deprecated [email protected]: This package is no longer supported.

npm warn deprecated [email protected]: Glob versions prior to v9 are no longer supported

npm warn deprecated [email protected]: 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 [email protected]... (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 [email protected] 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 [email protected]: 1

ERROR: Process exited with code 25`

@asgothian
Copy link
Collaborator

asgothian commented Sep 28, 2024

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
Copy link
Author

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: [email protected]
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: [email protected]
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
Copy link
Collaborator

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
Copy link
Author

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

@asgothian
Copy link
Collaborator

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
Copy link
Collaborator

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
Copy link
Collaborator

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
Copy link
Author

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

@michi2005
Copy link
Author

michi2005 commented Sep 28, 2024

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
Copy link
Collaborator

adapter runs too ? which version currently ?

@michi2005
Copy link
Author

1.10.9 works and 1.10.10 finally as well :)

@asgothian
Copy link
Collaborator

with no issue with regards to firmware scan ?

@michi2005
Copy link
Author

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

@michi2005
Copy link
Author

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

@asgothian
Copy link
Collaborator

Did the adapter crash or keep running ?

@michi2005
Copy link
Author

It kept running. No errors until now

@MiWoBln
Copy link

MiWoBln commented Oct 2, 2024

Hi @asgothian, your branch work very well :) thanks for the support.

Best Mirko

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

3 participants