search

Koenkk / zigbee2mqtt

Zigbee 🐝 to MQTT bridge 🌉, get rid of your proprietary Zigbee bridges 🔨
https://www.zigbee2mqtt.io
GNU General Public License v3.0
11.31k stars 1.61k forks source link

Error warnings with 1.37.0-1 #22544

Open raveit65 opened 1 month ago

raveit65 commented 1 month ago

What happened?

I see weird error warnings in z2m log after a new start of z2m.

[2024-05-08 18:28:57] info:     z2m: Licht Schlafz Boxen (0xf0d1b80000187efe): AC25697 - LEDVANCE SMART+ CLASSIC MULTICOLOUR 60 10W E27 (Router)
[2024-05-08 18:28:57] info:     z2m: Thermo Schlafz (0x00158d0001ff9101): SPZB0001 - Eurotronic Spirit Zigbee wireless heater thermostat (EndDevice)
[2024-05-08 18:28:57] info:     z2m: Zigbee: disabling joining new devices.
[2024-05-08 18:28:57] info:     z2m: Connecting to MQTT server at mqtt://core-mosquitto:1883
[2024-05-08 18:28:57] info:     z2m: Connected to MQTT server
[2024-05-08 18:28:58] info:     z2m: Started frontend on port 8099
[2024-05-08 18:28:58] info:     z2m: Zigbee2MQTT started!
[2024-05-08 18:29:12] error:    zh:zstack:znp: Error while parsing to ZpiObject 'Error: CommandID '159' from subsystem '5' not found
    at Function.fromUnpiFrame (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/zpiObject.ts:60:19)
    at Znp.onUnpiParsed (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:93:38)
    at Parser.emit (node:events:517:28)
    at Parser.parseNext (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:45:26)
    at Parser.parseNext (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:51:22)
    at Parser._transform (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:19:14)
    at Parser.Transform._write (node:internal/streams/transform:175:8)
    at writeOrBuffer (node:internal/streams/writable:392:12)
    at _write (node:internal/streams/writable:333:10)
    at Parser.Writable.write (node:internal/streams/writable:337:10)'
[2024-05-08 18:30:31] info:     z2m: Starting network scan (includeRoutes 'false')
[2024-05-08 18:31:19] info:     z2m: Network scan finished

z2m seems to be working but i missed a clean log without error warnings which i don't understand. Maybe this is evil?

What did you expect to happen?

No error warning in z2m log like it was with previous version.

How to reproduce it (minimal and precise)

Start or restart z2m on a hp ThinClint_t630

Zigbee2MQTT version

1.37.0-1

Adapter firmware version

13.4.0(zbbrdgpro)

Adapter

sonoff.zbbridge.pro with tasmota

Setup

plain on x86_64 , HP ThinClint_t630

Debug log

[2024-05-08 18:28:57] info: z2m: Licht Schlafz Boxen (0xf0d1b80000187efe): AC25697 - LEDVANCE SMART+ CLASSIC MULTICOLOUR 60 10W E27 (Router) [2024-05-08 18:28:57] info: z2m: Thermo Schlafz (0x00158d0001ff9101): SPZB0001 - Eurotronic Spirit Zigbee wireless heater thermostat (EndDevice) [2024-05-08 18:28:57] info: z2m: Zigbee: disabling joining new devices. [2024-05-08 18:28:57] info: z2m: Connecting to MQTT server at mqtt://core-mosquitto:1883 [2024-05-08 18:28:57] info: z2m: Connected to MQTT server [2024-05-08 18:28:58] info: z2m: Started frontend on port 8099 [2024-05-08 18:28:58] info: z2m: Zigbee2MQTT started! [2024-05-08 18:29:12] error: zh:zstack:znp: Error while parsing to ZpiObject 'Error: CommandID '159' from subsystem '5' not found at Function.fromUnpiFrame (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/zpiObject.ts:60:19) at Znp.onUnpiParsed (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:93:38) at Parser.emit (node:events:517:28) at Parser.parseNext (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:45:26) at Parser.parseNext (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:51:22) at Parser._transform (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:19:14) at Parser.Transform._write (node:internal/streams/transform:175:8) at writeOrBuffer (node:internal/streams/writable:392:12) at _write (node:internal/streams/writable:333:10) at Parser.Writable.write (node:internal/streams/writable:337:10)' [2024-05-08 18:30:31] info: z2m: Starting network scan (includeRoutes 'false') [2024-05-08 18:31:19] info: z2m: Network scan finished

Trashwarez commented 1 month ago

Same here.

Error "error: zh:zstack:znp: Error while parsing to ZpiObject 'Error: CommandID '159' from subsystem '5' not found"

pops up in the log after reboot on a Raspberry Pi 3 with Bookworm (aarch64, latest updates), NodeJS 20.13.1 and a SONOFF ZBDongle-P with firmware 20230507 holding 58 devices (19 routers, 39 end devices).

Flash of prior firmware versions did not help as well as the deletion of "data/ coordinator_backup.json".

Had to rollback to 1.36.1. Everything works fine on this.

Logfile:

[2024-05-09 19:24:11] error: <->zh:zstack:znp: Error while parsing to ZpiObject 'Error: CommandID '159' from subsystem '5' not found at Function.fromUnpiFrame (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/zpiObject.ts:60:19) at Znp.onUnpiParsed (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:93:38) at Parser.emit (node:events:519:28) at Parser.parseNext (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:45:26) at Parser.parseNext (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:51:22) at Parser.parseNext (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:51:22) at Parser.parseNext (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:51:22) at Parser._transform (/opt/zigbee2mqtt/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:19:14) at Parser.Transform._write (node:internal/streams/transform:171:8) at writeOrBuffer (node:internal/streams/writable:564:12)'

[ Repeated 5 times ]

RobertClarke64 commented 1 month ago

I have this issue too. But for me I only get this issue when I allow new devices to join and start the pairing sequence on a device. Once the error happens, I can't even try to pair new devices - nothing at all appears in the logs. I have to unplug the coordinator and restart Z2M, only then I can try to pair a device again, but it just gives me this error again.
Z2M Version 1.37.1
Coordinator SONOFF ZBDongle-P
Coordinator Firmware 20210708
No. Devices 15 (6 routers, 9 end devices)

Logs:

[2024-05-10 11:29:46] info:     z2m: Zigbee2MQTT started!
[2024-05-10 11:30:02] info:     z2m: Zigbee: allowing new devices to join.
[2024-05-10 11:30:28] error:    zh:zstack:znp: Error while parsing to ZpiObject 'Error: CommandID '159' from subsystem '5' not found
    at Function.fromUnpiFrame (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/zpiObject.ts:60:19)
    at Znp.onUnpiParsed (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:93:38)
    at Parser.emit (node:events:517:28)
    at Parser.parseNext (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:45:26)
    at Parser._transform (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:19:14)
    at Parser.Transform._write (node:internal/streams/transform:175:8)
    at writeOrBuffer (node:internal/streams/writable:392:12)
    at _write (node:internal/streams/writable:333:10)
    at Parser.Writable.write (node:internal/streams/writable:337:10)
    at SerialPort.ondata (node:internal/streams/readable:809:22)'
anthonym21 commented 4 weeks ago

My whole network is basically not working with this issue the only error in my log

kloodhu commented 4 weeks ago

same here.

Koenkk commented 3 weeks ago

Does this issue also occur with the following firmware? https://github.com/Koenkk/Z-Stack-firmware/discussions/496

anthonym21 commented 3 weeks ago

I'll try tonight, for now I was able to work around it by using TCP instead of websockets on the broker

On Sun, May 19, 2024, 15:45 Koen Kanters @.***> wrote:

Does this issue also occur with the following firmware? Koenkk/Z-Stack-firmware#496 https://github.com/Koenkk/Z-Stack-firmware/discussions/496

— Reply to this email directly, view it on GitHub https://github.com/Koenkk/zigbee2mqtt/issues/22544#issuecomment-2119340440, or unsubscribe https://github.com/notifications/unsubscribe-auth/AE5FPXHFNWBYWRO2LEBNZXLZDD6MVAVCNFSM6AAAAABHNLD5VGVHI2DSMVQWIX3LMV43OSLTON2WKQ3PNVWWK3TUHMZDCMJZGM2DANBUGA . You are receiving this because you commented.Message ID: @.***>

Trashwarez commented 3 weeks ago

Does this issue also occur with the following firmware? Koenkk/Z-Stack-firmware#496

Looks promising!

As stated above, the error popped up in my logs after reboot.

I rebooted 3 times now and can confirm that I don't have this error anymore on Zigbee2MQTT 1.37.1 when using the above posted firmware (20240315). I will check it again tomorrow and comment here if there are some issues.

harvindhillon commented 2 weeks ago

I am on the latest 20240316 firmware for P7 and latest Zigbee2MQTT 1.37.1, I still get this error on start up

I am on UZG-01 with the P7 chipset and firmware 20240316

daangel27 commented 2 weeks ago

Hello,

Same error using :

Logs:

_[2024-05-29 09:56:19] info: z2m: Started frontend on port 8099 [2024-05-29 09:56:20] info: z2m: Zigbee2MQTT started! [2024-05-29 09:56:29] error: zh:zstack:znp: Error while parsing to ZpiObject 'Error: CommandID '159' from subsystem '5' not found at Function.fromUnpiFrame (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/zpiObject.ts:60:19) at Znp.onUnpiParsed (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:93:38) at Parser.emit (node:events:517:28) at Parser.parseNext (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:45:26) at Parser._transform (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:19:14) at Parser.Transform._write (node:internal/streams/transform:175:8) at writeOrBuffer (node:internal/streams/writable:392:12) at write (node:internal/streams/writable:333:10) at Parser.Writable.write (node:internal/streams/writable:337:10) at SerialPort.ondata (node:internal/streams/readable:809:22)'

harvindhillon commented 1 week ago

I switched to the SMLIGHT SZLB-06 and get the same error as well on the latest test firmware 20240315

[2024-06-04 22:42:33] error: zh:zstack:znp: Error while parsing to ZpiObject 'Error: CommandID '159' from subsystem '5' not found at Function.fromUnpiFrame (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/zpiObject.ts:60:19) at Znp.onUnpiParsed (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:93:38) at Parser.emit (node:events:517:28) at Parser.parseNext (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:45:26) at Parser._transform (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/unpi/parser.ts:19:14) at Parser.Transform._write (node:internal/streams/transform:175:8) at writeOrBuffer (node:internal/streams/writable:392:12) at _write (node:internal/streams/writable:333:10) at Parser.Writable.write (node:internal/streams/writable:337:10) at Socket.ondata (node:internal/streams/readable:809:22)'

Koenkk commented 1 week ago

I'm going to start working on a 7.40 firmware, let's see if the issue still occurs with that one.