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

Z2M Keeps crashing #12031

Closed
Inrego opened this issue Apr 1, 2022 · 46 comments
Closed

Z2M Keeps crashing #12031

Inrego opened this issue Apr 1, 2022 · 46 comments
Labels
problem Something isn't working stale Stale issues

Comments

@Inrego
Copy link

Inrego commented Apr 1, 2022

What happened?

Very recently, my Z2M keeps crashing, with this error in the log:

RangeError: Offset is outside the bounds of the DataView
    at DataView.getUint32 (<anonymous>)
    at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
    at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
    at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
    at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
    at Driver.emit (node:events:526:28)
    at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
    at Parser.emit (node:events:526:28)
    at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
    at slip.Decoder.p.handleEnd (/app/node_modules/zigbee-herdsman/node_modules/slip/src/slip.js:189:18)
Using '/app/data' as data directory
CREATED DECONZ ADAPTER

It reboots roughly every 10 seconds.

What did you expect to happen?

No response

How to reproduce it (minimal and precise)

I'm not sure, I don't know what caused the issue.

Zigbee2MQTT version

1.25.0

Adapter firmware version

0x26680700

Adapter

Conbee II

Debug log

No response

@Inrego Inrego added the problem Something isn't working label Apr 1, 2022
@Inrego
Copy link
Author

Inrego commented Apr 2, 2022

Ok, I noticed that watchtower had updated zigbee2mqtt to 1.25.0
That seems to be the cause. I've rolled back to 1.24.0, and now it seems stable again.

@andrasg
Copy link

andrasg commented Apr 2, 2022

I am seeing a similar issue. Watchtower updated overnight, now z2m doesn't start.

Rolled back to 1.24.0 for now, but there part of my network seems to be offline.

Error with 1.25.0:

Using '/app/data' as data directory
#
# Fatal error in , line 0
# unreachable code
#
#
#
#FailureMessage Object: 0xbeb6863c

@markprins
Copy link

seeing same issues. Zigbee2mqtt running as docker container.

Log states:

#
# Fatal error in , line 0
# unreachable code
#
#
#
#FailureMessage Object: 0xbecd263c

@andrasg
Copy link

andrasg commented Apr 2, 2022

Happens on latest-dev too.

@Twit123
Copy link

Twit123 commented Apr 2, 2022

Did you see the release notes:

Important for users running Raspbian Buster: due to #11804, libseccomp2 is required which needs to be installed manually. If you do not do this the container will crash on startup. See the docs on how to do this.

Simon

@Inrego
Copy link
Author

Inrego commented Apr 2, 2022

I'm running in a Docker container on Ubuntu

@Koenkk
Copy link
Owner

Koenkk commented Apr 2, 2022

Using '/app/data' as data directory
#
# Fatal error in , line 0
# unreachable code
#
#
#
#FailureMessage Object: 0xbeb6863c

As @markprins mentioned this is due to libsecomp2, read the first note from https://github.com/Koenkk/zigbee2mqtt/releases

@ChrisHae could you look at the RangeError: Offset is outside the bounds of the DataView error?

@andrasg
Copy link

andrasg commented Apr 2, 2022

As @markprins mentioned this is due to libsecomp2, read the first note from https://github.com/Koenkk/zigbee2mqtt/releases

Thanks, this solved it for me. Even read it on the april's fool post yesterday, but completely forgot about it...

@ChrisHae
Copy link

ChrisHae commented Apr 4, 2022

could you look at the RangeError: Offset is outside the bounds of the DataView error?

The message is printed because it received a faulty frame. I will look at it and change the message.

@bkupidura
Copy link

So after update to 1.25.0 i start observing random crashes of z2m. It already happened twice in a week.
1.24.0 was rock solid.

RangeError: Offset is outside the bounds of the DataView
    at DataView.getUint8 (<anonymous>)
    at parseEnqueueSendDataResponse (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:292:28)
    at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
    at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
    at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
    at Driver.emit (node:events:526:28)
    at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
    at Parser.emit (node:events:526:28)
    at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
    at slip.Decoder.p.handleEnd (/app/node_modules/zigbee-herdsman/node_modules/slip/src/slip.js:189:18)

If this is caused by faulty frame, any reason for that? I didnt do anything (no new device) to zigbee network.
Also can we somehow handle those broken frames instead of just throwing panic?

@ChrisHae
Copy link

We would need to see a zigbee sniffer log to see the real origin and kind of the (faulty) frame that causes those messages.

Could anybody provide that?

@bkupidura
Copy link

I never did any zb sniffing, but i have spare cc2652p. So if there is any howto+firmware i can try.

One thing is that i need to avoid breaking my current network. So couple of questions:

  1. Sniffer should be part of network?
  2. Can i safetly add sniffer to my network without re-pairing everything else? :)

@ChrisHae
Copy link

here is a howto: https://www.zigbee2mqtt.io/advanced/zigbee/04_sniff_zigbee_traffic.html#with-cc2531

You keep your network as it is and use only the other stick for sniffing. It is a distinct process.

@nebhead
Copy link

nebhead commented Apr 27, 2022

For what it's worth, I am experiencing crashes with v1.25.0-dev as well. I'm running in a docker container on top of Ubuntu 20.04 Server. Did not experience these issues with v1.24.0 release either. I can't seem to pinpoint the error, but if someone could point me in the right direction as to what log to look at to get more information, that would be great.

@bkupidura
Copy link

Since my last comment, i didnt notice any restarts. So nothing to share yet.
Its strange, as i didnt do any changes to my zigbee devices (not before/right after update). But now looks like everything is working like before...

@nebhead
Copy link

nebhead commented Apr 29, 2022

Since my last comment, i didnt notice any restarts. So nothing to share yet. Its strange, as i didnt do any changes to my zigbee devices (not before/right after update). But now looks like everything is working like before...

Weirdly, mine has been up for two days now (since I last posted) and hasn't crashed. I'll keep an eye on it, but so far, so good.

@nebhead
Copy link

nebhead commented Apr 30, 2022

Since my last comment, i didnt notice any restarts. So nothing to share yet. Its strange, as i didnt do any changes to my zigbee devices (not before/right after update). But now looks like everything is working like before...

Weirdly, mine has been up for two days now (since I last posted) and hasn't crashed. I'll keep an eye on it, but so far, so good.

NM... crashed again about 15 hours ago, maybe right after posting my last response. Unfortunately, still no sign of what might be the issue. At least it's a silent crash, and docker spins right back up.

@nebhead
Copy link

nebhead commented May 8, 2022

FWIW - Observed another crash after about 4-days of up-time on the latest stable release v1.25.1.

@ChrisHae
Copy link

@nebhead How serious are those crashes? Aren't they just some error messages in the logs or does the whole program crash?

And could you provide a sniffer log maybe?

@Inrego
Copy link
Author

Inrego commented May 10, 2022

In my case, a crash means the Docker container crashes and stops. It's set to restart automatically, which it does. And as such, it would be ok if it just happened like once per day or so.
But every 10 seconds is a big problem.

@nebhead
Copy link

nebhead commented May 10, 2022

@nebhead How serious are those crashes? Aren't they just some error messages in the logs or does the whole program crash?

I'm running in a docker, and the docker container crashes and restarts automatically. In my case, it's usually after 1-2 days. Did not occur on v1.24.x

And could you provide a sniffer log maybe?

OK, so this is where I'm having some challenges and need some help. I've looked at the log in Portainer, and inside the UI of the Z2M application and it doesn't show enough history for me to track down the error. Does anyone have any advice on how I can get logs that are more persistent?

@Inrego
Copy link
Author

Inrego commented May 11, 2022

I just tried the latest version, and every 10 seconds might have been an overstatement I see. Here's a snippet from my log. The actual number is 33 crashes in 8,5 hours.

And none of my 100 zigbee devices are functional atm.

I reverted to 1.24.0 and it's working again.

2022-05-11T12:05:33.404617663Z Using '/app/data' as data directory
2022-05-11T12:05:34.587391799Z CREATED DECONZ ADAPTER
2022-05-11T12:06:24.533524992Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:06:24.533566930Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:06:24.533574265Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:06:24.533589887Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:06:24.533595767Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:06:24.533601550Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:06:24.533627307Z     at Driver.emit (node:events:527:28)
2022-05-11T12:06:24.533637613Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:06:24.533646613Z     at Parser.emit (node:events:527:28)
2022-05-11T12:06:24.533654992Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:06:24.533663669Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:06:25.331743353Z Using '/app/data' as data directory
2022-05-11T12:06:26.543065269Z CREATED DECONZ ADAPTER
2022-05-11T12:07:24.459733989Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:07:24.459778386Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:07:24.459786613Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:07:24.459794087Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:07:24.459799540Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:07:24.459805030Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:07:24.459810624Z     at Driver.emit (node:events:527:28)
2022-05-11T12:07:24.459815652Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:07:24.459821886Z     at Parser.emit (node:events:527:28)
2022-05-11T12:07:24.459829683Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:07:24.459838286Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:07:25.183134216Z Using '/app/data' as data directory
2022-05-11T12:07:26.371235747Z CREATED DECONZ ADAPTER
2022-05-11T12:07:54.464481897Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:07:54.464524090Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:07:54.464531833Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:07:54.464542550Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:07:54.464548386Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:07:54.464554131Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:07:54.464560046Z     at Driver.emit (node:events:527:28)
2022-05-11T12:07:54.464565350Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:07:54.464585112Z     at Parser.emit (node:events:527:28)
2022-05-11T12:07:54.464591498Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:07:54.464597348Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:07:55.210339466Z Using '/app/data' as data directory
2022-05-11T12:07:56.412011636Z CREATED DECONZ ADAPTER
2022-05-11T12:08:02.816513257Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:08:02.816575984Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:08:02.816594954Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:08:02.816620644Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:08:02.816626043Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:08:02.816630924Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:08:02.816635919Z     at Driver.emit (node:events:527:28)
2022-05-11T12:08:02.816640437Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:08:02.816645114Z     at Parser.emit (node:events:527:28)
2022-05-11T12:08:02.816649594Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:08:02.816654305Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:08:03.608003587Z Using '/app/data' as data directory
2022-05-11T12:08:04.806060639Z CREATED DECONZ ADAPTER
2022-05-11T12:08:24.407732157Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:08:24.407777476Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:08:24.407790286Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:08:24.407800887Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:08:24.407809003Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:08:24.407817691Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:08:24.407826676Z     at Driver.emit (node:events:527:28)
2022-05-11T12:08:24.407834981Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:08:24.407843892Z     at Parser.emit (node:events:527:28)
2022-05-11T12:08:24.407853693Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:08:24.407859665Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:08:25.183174451Z Using '/app/data' as data directory
2022-05-11T12:08:26.371488718Z CREATED DECONZ ADAPTER
2022-05-11T12:08:32.743356640Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:08:32.743393768Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:08:32.743399704Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:08:32.743406198Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:08:32.743410893Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:08:32.743415477Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:08:32.743420124Z     at Driver.emit (node:events:527:28)
2022-05-11T12:08:32.743424388Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:08:32.743429608Z     at Parser.emit (node:events:527:28)
2022-05-11T12:08:32.743437056Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:08:32.743444780Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:08:33.531632788Z Using '/app/data' as data directory
2022-05-11T12:08:34.705911653Z CREATED DECONZ ADAPTER
2022-05-11T12:09:02.703707511Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:09:02.703745561Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:09:02.703751722Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:09:02.703758168Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:09:02.703763006Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:09:02.703767821Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:09:02.703772659Z     at Driver.emit (node:events:527:28)
2022-05-11T12:09:02.703777059Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:09:02.703781704Z     at Parser.emit (node:events:527:28)
2022-05-11T12:09:02.703788455Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:09:02.703795559Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:09:03.440160317Z Using '/app/data' as data directory
2022-05-11T12:09:04.658640648Z CREATED DECONZ ADAPTER
2022-05-11T12:09:07.738917955Z RangeError: The value of "offset" is out of range. It must be >= 0 and <= 14. Received 15
2022-05-11T12:09:07.738957756Z     at new NodeError (node:internal/errors:372:5)
2022-05-11T12:09:07.738964430Z     at boundsError (node:internal/buffer:86:9)
2022-05-11T12:09:07.738969816Z     at Buffer.readUInt16LE (node:internal/buffer:243:5)
2022-05-11T12:09:07.738974841Z     at BuffaloZcl.readUInt16 (/app/node_modules/zigbee-herdsman/src/buffalo/buffalo.ts:79:35)
2022-05-11T12:09:07.738979957Z     at BuffaloZcl.readGdpFrame (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:397:40)
2022-05-11T12:09:07.738985010Z     at BuffaloZcl.read (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:647:25)
2022-05-11T12:09:07.738990319Z     at Function.parsePayloadCluster (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:245:47)
2022-05-11T12:09:07.738995335Z     at Function.parsePayload (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:216:25)
2022-05-11T12:09:07.739000279Z     at Function.fromBuffer (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:186:30)
2022-05-11T12:09:07.739005217Z     at DeconzAdapter.checkReceivedGreenPowerIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:1058:29)
2022-05-11T12:09:08.464747853Z Using '/app/data' as data directory
2022-05-11T12:09:09.679351484Z CREATED DECONZ ADAPTER
2022-05-11T12:09:24.310605766Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:09:24.310645088Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:09:24.310666166Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:09:24.310676471Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:09:24.310684793Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:09:24.310692908Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:09:24.310702196Z     at Driver.emit (node:events:527:28)
2022-05-11T12:09:24.310722957Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:09:24.310745606Z     at Parser.emit (node:events:527:28)
2022-05-11T12:09:24.310753397Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:09:24.310760964Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:09:25.116226985Z Using '/app/data' as data directory
2022-05-11T12:09:26.294315221Z CREATED DECONZ ADAPTER
2022-05-11T12:09:32.671620455Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:09:32.671656005Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:09:32.671662158Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:09:32.671683886Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:09:32.671689422Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:09:32.671694262Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:09:32.671699339Z     at Driver.emit (node:events:527:28)
2022-05-11T12:09:32.671703862Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:09:32.671722403Z     at Parser.emit (node:events:527:28)
2022-05-11T12:09:32.671730163Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:09:32.671738030Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:09:33.455731908Z Using '/app/data' as data directory
2022-05-11T12:09:34.650673507Z CREATED DECONZ ADAPTER
2022-05-11T12:10:02.599348837Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:10:02.599393424Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:10:02.599403654Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:10:02.599412565Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:10:02.599417163Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:10:02.599421564Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:10:02.599425984Z     at Driver.emit (node:events:527:28)
2022-05-11T12:10:02.599430024Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:10:02.599434314Z     at Parser.emit (node:events:527:28)
2022-05-11T12:10:02.599438349Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:10:02.599442600Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:10:03.438524433Z Using '/app/data' as data directory
2022-05-11T12:10:04.616560314Z CREATED DECONZ ADAPTER
2022-05-11T12:10:49.237482786Z TypeError: Cannot read properties of undefined (reading 'toUpperCase')
2022-05-11T12:10:49.237527749Z     at BuffaloZcl.read (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:672:36)
2022-05-11T12:10:49.237546138Z     at BuffaloZcl.readGdpFrame (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:419:52)
2022-05-11T12:10:49.237554122Z     at BuffaloZcl.read (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:647:25)
2022-05-11T12:10:49.237577484Z     at Function.parsePayloadCluster (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:245:47)
2022-05-11T12:10:49.237585469Z     at Function.parsePayload (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:216:25)
2022-05-11T12:10:49.237592636Z     at Function.fromBuffer (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:186:30)
2022-05-11T12:10:49.237599737Z     at DeconzAdapter.checkReceivedGreenPowerIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:1058:29)
2022-05-11T12:10:49.237607595Z     at EventEmitter.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:78:87)
2022-05-11T12:10:49.237625528Z     at EventEmitter.emit (node:events:527:28)
2022-05-11T12:10:49.237632362Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:361:27)
2022-05-11T12:10:50.006832535Z Using '/app/data' as data directory
2022-05-11T12:10:51.188989547Z CREATED DECONZ ADAPTER
2022-05-11T12:11:02.521325419Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:11:02.521369532Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:11:02.521374166Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:11:02.521391409Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:11:02.521395118Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:11:02.521398738Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:11:02.521402439Z     at Driver.emit (node:events:527:28)
2022-05-11T12:11:02.521407414Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:11:02.521412968Z     at Parser.emit (node:events:527:28)
2022-05-11T12:11:02.521418710Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:11:02.521424690Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:11:03.247231501Z Using '/app/data' as data directory
2022-05-11T12:11:04.422562213Z CREATED DECONZ ADAPTER
2022-05-11T12:12:24.035059975Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:12:24.035094813Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:12:24.035101050Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:12:24.035109164Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:12:24.035113398Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:12:24.035117496Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:12:24.035132857Z     at Driver.emit (node:events:527:28)
2022-05-11T12:12:24.035137239Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:12:24.035141268Z     at Parser.emit (node:events:527:28)
2022-05-11T12:12:24.035145085Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:12:24.035149029Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:12:24.811401762Z Using '/app/data' as data directory
2022-05-11T12:12:25.976759798Z CREATED DECONZ ADAPTER
2022-05-11T12:12:54.025728874Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:12:54.025772975Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:12:54.025792644Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:12:54.025855205Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:12:54.025881163Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:12:54.025889945Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:12:54.025897912Z     at Driver.emit (node:events:527:28)
2022-05-11T12:12:54.025902764Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:12:54.025907481Z     at Parser.emit (node:events:527:28)
2022-05-11T12:12:54.025912479Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:12:54.025916913Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:12:54.730919965Z Using '/app/data' as data directory
2022-05-11T12:12:55.907296915Z CREATED DECONZ ADAPTER
2022-05-11T12:13:04.035567171Z TypeError: Cannot read properties of undefined (reading 'toUpperCase')
2022-05-11T12:13:04.035607111Z     at BuffaloZcl.read (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:672:36)
2022-05-11T12:13:04.035615015Z     at BuffaloZcl.readGdpFrame (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:419:52)
2022-05-11T12:13:04.035619391Z     at BuffaloZcl.read (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:647:25)
2022-05-11T12:13:04.035623254Z     at Function.parsePayloadCluster (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:245:47)
2022-05-11T12:13:04.035627065Z     at Function.parsePayload (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:216:25)
2022-05-11T12:13:04.035630871Z     at Function.fromBuffer (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:186:30)
2022-05-11T12:13:04.035646740Z     at DeconzAdapter.checkReceivedGreenPowerIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:1058:29)
2022-05-11T12:13:04.035651369Z     at EventEmitter.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:78:87)
2022-05-11T12:13:04.035655570Z     at EventEmitter.emit (node:events:527:28)
2022-05-11T12:13:04.035659184Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:361:27)
2022-05-11T12:13:04.753237533Z Using '/app/data' as data directory
2022-05-11T12:13:05.961298373Z CREATED DECONZ ADAPTER
2022-05-11T12:13:23.953598391Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:13:23.953640356Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:13:23.953648930Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:13:23.953660289Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:13:23.953674845Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:13:23.953681252Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:13:23.953685156Z     at Driver.emit (node:events:527:28)
2022-05-11T12:13:23.953688654Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:13:23.953692357Z     at Parser.emit (node:events:527:28)
2022-05-11T12:13:23.953695813Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:13:23.953708521Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:13:24.754772747Z Using '/app/data' as data directory
2022-05-11T12:13:25.938264813Z CREATED DECONZ ADAPTER
2022-05-11T12:13:34.508414268Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:13:34.508445252Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:13:34.508451150Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:13:34.508457650Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:13:34.508462417Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:13:34.508467274Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:13:34.508472883Z     at Driver.emit (node:events:527:28)
2022-05-11T12:13:34.508479659Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:13:34.508487194Z     at Parser.emit (node:events:527:28)
2022-05-11T12:13:34.508518077Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:13:34.508526399Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:13:35.360159445Z Using '/app/data' as data directory
2022-05-11T12:13:36.542557008Z CREATED DECONZ ADAPTER
2022-05-11T12:13:44.023631448Z TypeError: Cannot read properties of undefined (reading 'toString')
2022-05-11T12:13:44.023675691Z     at Controller.onDeviceJoinedGreenPower (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:457:41)
2022-05-11T12:13:44.023703329Z     at GreenPower.emit (node:events:527:28)
2022-05-11T12:13:44.023710594Z     at GreenPower.onZclGreenPowerData (/app/node_modules/zigbee-herdsman/src/controller/greenPower.ts:174:18)
2022-05-11T12:13:44.023717598Z     at Controller.onZclOrRawData (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:581:17)
2022-05-11T12:13:44.970504432Z Using '/app/data' as data directory
2022-05-11T12:13:46.185279396Z CREATED DECONZ ADAPTER
2022-05-11T12:14:04.468619173Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:14:04.468678455Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:14:04.468696354Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:14:04.468723341Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:14:04.468732404Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:14:04.468740773Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:14:04.468759497Z     at Driver.emit (node:events:527:28)
2022-05-11T12:14:04.468775020Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:14:04.468780565Z     at Parser.emit (node:events:527:28)
2022-05-11T12:14:04.468785695Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:14:04.468791065Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:14:05.242587120Z Using '/app/data' as data directory
2022-05-11T12:14:06.429091722Z CREATED DECONZ ADAPTER
2022-05-11T12:14:35.000530766Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:14:35.000574573Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:14:35.000585796Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:14:35.000615130Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:14:35.000625402Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:14:35.000651364Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:14:35.000658401Z     at Driver.emit (node:events:527:28)
2022-05-11T12:14:35.000663649Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:14:35.000669071Z     at Parser.emit (node:events:527:28)
2022-05-11T12:14:35.000674236Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:14:35.000679658Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:14:35.755558738Z Using '/app/data' as data directory
2022-05-11T12:14:36.998021621Z CREATED DECONZ ADAPTER
2022-05-11T12:15:05.507656125Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:15:05.507708997Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:15:05.507722726Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:15:05.507728273Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:15:05.507732114Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:15:05.507735834Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:15:05.507739631Z     at Driver.emit (node:events:527:28)
2022-05-11T12:15:05.507743036Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:15:05.507746613Z     at Parser.emit (node:events:527:28)
2022-05-11T12:15:05.507750019Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:15:05.507753609Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:15:06.222978668Z Using '/app/data' as data directory
2022-05-11T12:15:07.399868815Z CREATED DECONZ ADAPTER
2022-05-11T12:15:35.720096829Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:15:35.720137836Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:15:35.720144734Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:15:35.720154758Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:15:35.720160120Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:15:35.720166812Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:15:35.720195835Z     at Driver.emit (node:events:527:28)
2022-05-11T12:15:35.720206290Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:15:35.720214506Z     at Parser.emit (node:events:527:28)
2022-05-11T12:15:35.720222094Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:15:35.720231369Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:15:36.460081432Z Using '/app/data' as data directory
2022-05-11T12:15:37.644492241Z CREATED DECONZ ADAPTER
2022-05-11T12:16:36.207440762Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:16:36.207485407Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:16:36.207505311Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:16:36.207522201Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:16:36.207535853Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:16:36.207548758Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:16:36.207562100Z     at Driver.emit (node:events:527:28)
2022-05-11T12:16:36.207575132Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:16:36.207594235Z     at Parser.emit (node:events:527:28)
2022-05-11T12:16:36.207604294Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:16:36.207610165Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:16:37.015173161Z Using '/app/data' as data directory
2022-05-11T12:16:38.201340264Z CREATED DECONZ ADAPTER
2022-05-11T12:17:25.575673625Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:17:25.575718400Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:17:25.575730871Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:17:25.575744908Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:17:25.575750735Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:17:25.575755758Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:17:25.575761226Z     at Driver.emit (node:events:527:28)
2022-05-11T12:17:25.575765958Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:17:25.575770994Z     at Parser.emit (node:events:527:28)
2022-05-11T12:17:25.575812553Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:17:25.575827111Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:17:26.363393476Z Using '/app/data' as data directory
2022-05-11T12:17:27.574865042Z CREATED DECONZ ADAPTER
2022-05-11T12:17:55.542717526Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:17:55.542761391Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:17:55.542767660Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:17:55.542792560Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:17:55.542820609Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:17:55.542825843Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:17:55.542830597Z     at Driver.emit (node:events:527:28)
2022-05-11T12:17:55.542834889Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:17:55.542839521Z     at Parser.emit (node:events:527:28)
2022-05-11T12:17:55.542843725Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:17:55.542848164Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:17:56.317738964Z Using '/app/data' as data directory
2022-05-11T12:17:57.503787246Z CREATED DECONZ ADAPTER
2022-05-11T12:18:41.095658390Z RangeError: The value of "offset" is out of range. It must be >= 0 and <= 15. Received 16
2022-05-11T12:18:41.095702478Z     at new NodeError (node:internal/errors:372:5)
2022-05-11T12:18:41.095711760Z     at boundsError (node:internal/buffer:86:9)
2022-05-11T12:18:41.095718564Z     at Buffer.readUInt8 (node:internal/buffer:252:5)
2022-05-11T12:18:41.095725244Z     at BuffaloZcl.readUInt8 (/app/node_modules/zigbee-herdsman/src/buffalo/buffalo.ts:46:35)
2022-05-11T12:18:41.095732262Z     at BuffaloZcl.readGdpFrame (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:327:31)
2022-05-11T12:18:41.095739110Z     at BuffaloZcl.read (/app/node_modules/zigbee-herdsman/src/zcl/buffaloZcl.ts:647:25)
2022-05-11T12:18:41.095745480Z     at Function.parsePayloadCluster (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:245:47)
2022-05-11T12:18:41.095752167Z     at Function.parsePayload (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:216:25)
2022-05-11T12:18:41.095759070Z     at Function.fromBuffer (/app/node_modules/zigbee-herdsman/src/zcl/zclFrame.ts:186:30)
2022-05-11T12:18:41.095763712Z     at DeconzAdapter.checkReceivedGreenPowerIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:1058:29)
2022-05-11T12:18:41.818517145Z Using '/app/data' as data directory
2022-05-11T12:18:43.140532252Z CREATED DECONZ ADAPTER
2022-05-11T12:18:55.391478479Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:18:55.391518250Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:18:55.391526122Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:18:55.391537400Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:18:55.391543148Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:18:55.391551491Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:18:55.391555810Z     at Driver.emit (node:events:527:28)
2022-05-11T12:18:55.391559311Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:18:55.391562982Z     at Parser.emit (node:events:527:28)
2022-05-11T12:18:55.391566424Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:18:55.391570052Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:18:56.119645760Z Using '/app/data' as data directory
2022-05-11T12:18:57.446953946Z CREATED DECONZ ADAPTER
2022-05-11T12:19:05.977322764Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:19:05.977354918Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:19:05.977364683Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:19:05.977374147Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:19:05.977380751Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:19:05.977387209Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:19:05.977393861Z     at Driver.emit (node:events:527:28)
2022-05-11T12:19:05.977400170Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:19:05.977405900Z     at Parser.emit (node:events:527:28)
2022-05-11T12:19:05.977411698Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:19:05.977417598Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:19:06.872425458Z Using '/app/data' as data directory
2022-05-11T12:19:08.231347519Z CREATED DECONZ ADAPTER
2022-05-11T12:19:25.357952093Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:19:25.357994190Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:19:25.358003029Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:19:25.358013169Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:19:25.358019710Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:19:25.358025973Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:19:25.358032492Z     at Driver.emit (node:events:527:28)
2022-05-11T12:19:25.358038103Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:19:25.358044057Z     at Parser.emit (node:events:527:28)
2022-05-11T12:19:25.358049769Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:19:25.358055835Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:19:26.106719719Z Using '/app/data' as data directory
2022-05-11T12:19:27.464093235Z CREATED DECONZ ADAPTER
2022-05-11T12:19:35.890246061Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:19:35.890277748Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:19:35.890282487Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:19:35.890287494Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:19:35.890291186Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:19:35.890294789Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:19:35.890298490Z     at Driver.emit (node:events:527:28)
2022-05-11T12:19:35.890301924Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:19:35.890305444Z     at Parser.emit (node:events:527:28)
2022-05-11T12:19:35.890308758Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:19:35.890312243Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:19:36.686411392Z Using '/app/data' as data directory
2022-05-11T12:19:38.005548474Z CREATED DECONZ ADAPTER
2022-05-11T12:20:05.805435664Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:20:05.805486486Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:20:05.805496566Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:20:05.805516799Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:20:05.805521692Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:20:05.805526053Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:20:05.805532425Z     at Driver.emit (node:events:527:28)
2022-05-11T12:20:05.805538478Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:20:05.805544383Z     at Parser.emit (node:events:527:28)
2022-05-11T12:20:05.805558275Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:20:05.805564286Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)
2022-05-11T12:20:06.631669836Z Using '/app/data' as data directory
2022-05-11T12:20:07.904578914Z CREATED DECONZ ADAPTER
2022-05-11T12:20:25.223990110Z RangeError: Offset is outside the bounds of the DataView
2022-05-11T12:20:25.224032925Z     at DataView.getUint32 (<anonymous>)
2022-05-11T12:20:25.224041379Z     at parseGreenPowerDataIndication (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:339:33)
2022-05-11T12:20:25.224049405Z     at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
2022-05-11T12:20:25.224055371Z     at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
2022-05-11T12:20:25.224061147Z     at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
2022-05-11T12:20:25.224067265Z     at Driver.emit (node:events:527:28)
2022-05-11T12:20:25.224072889Z     at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
2022-05-11T12:20:25.224078906Z     at Parser.emit (node:events:527:28)
2022-05-11T12:20:25.224084379Z     at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
2022-05-11T12:20:25.224090163Z     at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)

@Inrego
Copy link
Author

Inrego commented May 11, 2022

could you look at the RangeError: Offset is outside the bounds of the DataView error?

The message is printed because it received a faulty frame. I will look at it and change the message.

I just tried 1.25.1 and the message is the same. I don't have a sniffer at hand, but 1.24.0 is still working for me. So something changed from 1.24.0 to 1.25.0 which affects this.

@ChrisHae
Copy link

Well these information pinpoint the problem pretty precisely. I will try to find a fix and upload soon.

Just to be curious: do you have any Green Power Devices?

@Inrego
Copy link
Author

Inrego commented May 13, 2022

Yes I do. And I also have a small suspicion of the device that's causing it. Are you on Discord? If so, hit me up there. Else, I'll try to give a long explanation here

@bkupidura
Copy link

@ChrisHae just FYI i dont own any Green Power devices and i observed those issues also.

@Inrego
Copy link
Author

Inrego commented May 13, 2022

@bkupidura does your error messages look the same? With parseGreenPowerDataIndication in the stacktrace?

@bkupidura
Copy link

bkupidura commented May 13, 2022

Nope, my last stack trace:

RangeError: Offset is outside the bounds of the DataView
    at DataView.getUint8 (<anonymous>)
    at parseReceivedDataNotification (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:306:30)
    at parseFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:466:29)
    at processFrame (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/frameParser.ts:414:59)
    at Driver.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/deconz/adapter/deconzAdapter.ts:69:59)
    at Driver.emit (node:events:527:28)
    at Driver.onParsed (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/driver.ts:784:14)
    at Parser.emit (node:events:527:28)
    at Parser.onMessage (/app/node_modules/zigbee-herdsman/src/adapter/deconz/driver/parser.ts:30:14)
    at slip.Decoder.p.handleEnd (/app/node_modules/slip/src/slip.js:189:18)

But as you said, 1.24.0 was rock solid. So i would expect that something has changed in z2m between 1.24 and 1.25.

@ChrisHae
Copy link

@Inrego perhaps you could test your network without that device.
@bkupidura Thats the same error but origin from another function.
So I will try something and if it fixes the crashes. Perhaps would be interesting to see what devices causes that error in your network.

When you enable zigbee-herdsman debug logging we should be able to see the network address of that device.
https://www.zigbee2mqtt.io/guide/usage/debug.html

@Inrego
Copy link
Author

Inrego commented May 13, 2022

Alright, so that indicates it's not related to GreenPower. Although I do believe I have a GreenPower device gone rogue that's causing the crashes, the crashes seem to happen when receiving a bad frame (GreenPower or not).

More info on my rogue GreenPower device:
A GreenPower device keeps trying to join my Zigbee network. Once joined, it's spamming errors (on 1.24.0):

Zigbee2MQTT:debug 2022-05-13 08:48:08: Received Zigbee message from '0x00000000e202b874', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[111,50,182,171,142,127,40,100,124,30,245,138,8,43,121,37,192,51,88,212,114,94,56,207,252,89,20,237,92,237,129,55,196,110,107,124,196,87,164,154,33,123,185,204,141,146,122,156,204,66,34,134,5,225,131,222,79,185,211,116,113,208,121,118,129,22],"type":"Buffer"}},"commandID":75,"frameCounter":3371391,"gppGddLink":182,"gppNwkAddr":12911,"options":2608,"payloadSize":59,"srcID":3791829108}' from endpoint 242 with groupID null
Zigbee2MQTT:warn  2022-05-13 08:48:08: Received message from unsupported device with Zigbee model 'GreenPower_117' and manufacturer name 'undefined'
Zigbee2MQTT:warn  2022-05-13 08:48:08: Please see: https://www.zigbee2mqtt.io/advanced/support-new-devices/01_support_new_devices.html

On 1.25.0+, the device doesn't join, Z2M just crashes.

The Model (and I think network address) of the joined device keeps changing, so even if I block it from joining again, it joins again shortly after.

I am pretty certain that this rogue GreenPower device is a Schneider Electric PowerTag. Strange thing is, it's already connected to a separate Zigbee network (the Schneider Electric hub).

Also, Z2M version 1.25.1 adds support for these PowerTags, so I'm not sure why they keep crashing on that version. Maybe because they behave differently when connected to their own hub.

@bkupidura
Copy link

@ChrisHae i enabled debug, lets see. But for me those crashes are not that often (like once or twice per week). So probably i need couple of days to share anything.

@Inrego
Copy link
Author

Inrego commented May 13, 2022

I can now confirm the rogue device. I switched it off, and the errors stopped.

Another strange thing, I have 2 of them. Only one does this. But that's more of a device related problem, not a Z2M problem I figure.

EDIT: I'll now try to update, and pair the rogue PowerTag to Z2M

@Inrego
Copy link
Author

Inrego commented May 13, 2022

Ok, I've updated to 1.25.1 and paired the device successfully. However, I'm still getting a lot of crashes.

@ChrisHae
Copy link

So I have added some quick fixes. Those errors should now be catched and hopefully does not cause crashes anymore.
You could test it. It should be available in the mqtt dev branch in the next release (which should be out soon I think?)

When posting some logs it would be helpfull when zigbee-herdsman debug logging is enabled.

@inegro Do you have checked if the two GP devices have a different firmware version? Perhaps a newer firmware could be the solution there.

@Inrego
Copy link
Author

Inrego commented May 13, 2022

On the new latest-dev, and now I'm getting this error:

Error: Unhandled error. ('APS TIMEOUT')
    at new NodeError (node:internal/errors:372:5)
    at DeconzAdapter.emit (node:events:516:17)
    at emitUnhandledRejectionOrErr (node:events:384:10)
    at processTicksAndRejections (node:internal/process/task_queues:85:21)

@Inrego
Copy link
Author

Inrego commented May 13, 2022

Trying a few different things on my end. Will give more info tomorrow

@Inrego
Copy link
Author

Inrego commented May 14, 2022

I've left it overnight, and the container has been running for 8 hours without crash.

With the small caveat that none of my ZigBee devices are working, lol

Edit: restarted Z2M and now they're working again. Will get back to you again later

@Inrego
Copy link
Author

Inrego commented May 14, 2022

Ok so far it seems to be running alright until I "Permit Join" on my network.

Here's something from my log. It seems to be running ok, although being spammed a lot with some greenpower messages (which it says is from the coordinator?).
After I Permit Join, shortly after an error is thrown followed by Z2M crash

Zigbee2MQTT:debug 2022-05-14 07:38:28: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[235,43,91,125,161,90,120,82,36,60,113,218,252,8,181,75,100,13,183,216,5,199,165,4,230],"type":"Buffer"}},"commandID":0,"frameCounter":877802526,"gpdEndpoint":226,"gpdIEEEAddr":"0xc705d8b702b84b58","options":13394,"payloadSize":238}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:28: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:29: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2482,"rmsCurrent":132}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:38:29: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.32,"linkquality":255,"power":248.2,"state":"ON","voltage":232.83}'
Zigbee2MQTT:debug 2022-05-14 07:38:29: Retrieving state of 'Hus Motion Sensor 1' after reconnect
Zigbee2MQTT:debug 2022-05-14 07:38:33: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[47,244,218,158,165,175,85,181,141,169,77,40,225,178,47,161,61,75,84,108,93,27,248,252,234,165,207,9,196,170,165,165,249,6,155,239,101,138,231,113,120,186,234,160,21,95,12,208,85,201,199],"type":"Buffer"}},"commandID":0,"frameCounter":877803064,"gpdEndpoint":226,"gpdIEEEAddr":"0x1b5d6c5402b84b18","options":13394,"payloadSize":50}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:33: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[122,29,114,205,104,95,174,244,164,190,212,208,70,121,85,103,59,230,222,223,231,9,89,98,185],"type":"Buffer"}},"commandID":0,"frameCounter":877803294,"gpdEndpoint":226,"gpdIEEEAddr":"0x09e7dfde02b84b58","options":13394,"payloadSize":72}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:37: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2432,"rmsVoltage":23293}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:38:37: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.32,"linkquality":255,"power":243.2,"state":"ON","voltage":232.93}'
Zigbee2MQTT:debug 2022-05-14 07:38:37: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[220,242,17,167,117,229,60,16,82,220,127,220,38,5,212,240,136,83,245,246,94,24,28,203,16,10,252,48,233,95,149,175,229,201,21,157,143,26,116,65,174,227,86,201,97,246,66,31,70,47,245],"type":"Buffer"}},"commandID":0,"frameCounter":877803832,"gpdEndpoint":226,"gpdIEEEAddr":"0x185ef6f502b84b18","options":13394,"payloadSize":125}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:37: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[107,95,172,126,175,133,14,26,185,120,75,240,51,9,34,103,98,7,137,142,160,10,236,114,123],"type":"Buffer"}},"commandID":0,"frameCounter":877804062,"gpdEndpoint":226,"gpdIEEEAddr":"0x0aa08e8902b84b58","options":13394,"payloadSize":54}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:37: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:38: Received Zigbee message from 'Hus Motion Sensor 1', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:38:38: Device 'Hus Motion Sensor 1' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:38:38: Check if update available for '0x001788010949d3ed' (SML002)
Zigbee2MQTT:debug 2022-05-14 07:38:38: ZigbeeOTA: downloaded main index
Zigbee2MQTT:debug 2022-05-14 07:38:38: Is new image available for '0x001788010949d3ed', current '{"fieldControl":0,"manufacturerCode":4107,"imageType":269,"fileVersion":1107321517}', latest meta '{"fileVersion":1107323831,"fileSize":240760,"url":"http://fds.dc1.philips.com/firmware/ZGB_100B_010D/1107323831/Sensor-ATmega_6.1.1.27575_0012.sbl-ota","sha512":"10e549c55d262b2f227b75817f6620be407f537e04ac08db4dbebdf53e8d460299a2cda248b3be13476757d61a1c79b632963c4f126cd26b7c18ea6a2ab4ac59"}'
Zigbee2MQTT:debug 2022-05-14 07:38:38: Update available for '0x001788010949d3ed': YES
Zigbee2MQTT:info  2022-05-14 07:38:38: MQTT publish: topic 'zigbee2mqtt/Hus Motion Sensor 1', payload '{"battery":100,"illuminance":37212,"illuminance_lux":5261,"led_indication":true,"linkquality":255,"motion_sensitivity":"high","occupancy":false,"occupancy_timeout":null,"temperature":13.11,"update":{"state":"available"},"update_available":true}'
Zigbee2MQTT:info  2022-05-14 07:38:38: Update available for 'Hus Motion Sensor 1'
Zigbee2MQTT:info  2022-05-14 07:38:38: MQTT publish: topic 'zigbee2mqtt/bridge/log', payload '{"message":"Update available for 'Hus Motion Sensor 1'","meta":{"device":"Hus Motion Sensor 1","status":"available"},"type":"ota_update"}'
Zigbee2MQTT:debug 2022-05-14 07:38:42: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[103,200,178,207,173,10,71,43,98,219,12,85,109,2,235,219,206,97,20,102,195,71,86,131,216,73,177,163,79,65,121,1,80,198,47,218,247,102,138,45,15,250,193,32,163,151,229,16,34,133,224],"type":"Buffer"}},"commandID":0,"frameCounter":877804600,"gpdEndpoint":226,"gpdIEEEAddr":"0x47c3661402b84b18","options":13394,"payloadSize":191}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:42: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[86,248,88,43,66,31,33,48,62,88,241,247,6,148,124,23,77,118,146,67,137,79,67,249,80],"type":"Buffer"}},"commandID":0,"frameCounter":877804830,"gpdEndpoint":226,"gpdIEEEAddr":"0x4f89439202b84b58","options":13394,"payloadSize":249}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:42: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:45: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2752,"rmsCurrent":141}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:38:45: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.41,"linkquality":255,"power":275.2,"state":"ON","voltage":232.93}'
Zigbee2MQTT:debug 2022-05-14 07:38:45: Saving state to file /app/data/state.json
Zigbee2MQTT:debug 2022-05-14 07:38:46: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[230,183,79,235,101,124,58,76,220,138,51,31,41,78,112,145,184,208,214,254,125,118,231,105,66],"type":"Buffer"}},"commandID":0,"frameCounter":877805598,"gpdEndpoint":226,"gpdIEEEAddr":"0x767dfed602b84b58","options":13394,"payloadSize":58}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:47: Received Zigbee message from 'Hus Motion Sensor 1', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:38:47: Device 'Hus Motion Sensor 1' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:38:51: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[6,103,136,144,250,159,206,128,217,3,187,32,122,144,62,232,7,103,96,145,192,154,194,208,165,147,167,3,85,126,185,46,206,124,166,221,22,69,28,11,185,30,115,108,110,16,250,12,145,128,85],"type":"Buffer"}},"commandID":0,"frameCounter":877806136,"gpdEndpoint":226,"gpdIEEEAddr":"0x9ac0916002b84b18","options":13394,"payloadSize":165}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:51: Received Zigbee message from 'Hue Motion Sensor 6', type 'attributeReport', cluster 'msIlluminanceMeasurement', data '{"measuredValue":13024}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:38:51: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 6', payload '{"battery":100,"illuminance":13024,"illuminance_lux":20,"led_indication":null,"linkquality":26,"motion_sensitivity":"high","occupancy":false,"occupancy_timeout":0,"temperature":20.57,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:38:52: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:52: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2776,"rmsVoltage":23268}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:38:52: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.41,"linkquality":255,"power":277.6,"state":"ON","voltage":232.68}'
Zigbee2MQTT:debug 2022-05-14 07:38:53: Received Zigbee message from 'Stald Motion Sensor 1', type 'attributeReport', cluster 'msIlluminanceMeasurement', data '{"measuredValue":42550}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:38:53: MQTT publish: topic 'zigbee2mqtt/Stald Motion Sensor 1', payload '{"battery":100,"illuminance":42550,"illuminance_lux":17985,"led_indication":false,"linkquality":255,"motion_sensitivity":"high","occupancy":false,"occupancy_timeout":0,"temperature":13.76,"update":{"state":"available"},"update_available":true}'
Zigbee2MQTT:debug 2022-05-14 07:38:55: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[99,49,143,130,93,241,57,107,110,18,129,109,40,62,90,90,109,147,99,147,155,119,192,93,196,33,205,206,7,236,136,219,198,63,66,171,67,164,145,206,125,239,98,7,239,52,168,142,225,232,207],"type":"Buffer"}},"commandID":0,"frameCounter":877806904,"gpdEndpoint":226,"gpdIEEEAddr":"0x779b936302b84b18","options":13394,"payloadSize":175}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:55: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[195,63,120,182,170,206,103,246,70,232,65,114,214,198,108,83,147,134,65,209,190,156,163,125,160],"type":"Buffer"}},"commandID":0,"frameCounter":877807134,"gpdEndpoint":226,"gpdIEEEAddr":"0x9cbed14102b84b58","options":13394,"payloadSize":242}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:56: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:38:57: Received Zigbee message from 'Hus Motion Sensor 1', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:38:57: Device 'Hus Motion Sensor 1' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:39:00: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[64,18,155,118,227,82,111,229,182,251,72,94,66,132,83,75,131,245,24,193,236,162,91,73,235,55,156,8,17,138,226,2,48,39,57,34,12,174,184,52,177,250,52,202,30,140,62,153,184,208,103],"type":"Buffer"}},"commandID":0,"frameCounter":877807672,"gpdEndpoint":226,"gpdIEEEAddr":"0xa2ecc11802b84b18","options":13394,"payloadSize":151}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:00: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[198,242,170,170,218,14,162,201,23,235,221,212,23,127,151,186,103,22,95,15,3,21,156,153,25],"type":"Buffer"}},"commandID":0,"frameCounter":877807902,"gpdEndpoint":226,"gpdIEEEAddr":"0x15030f5f02b84b58","options":13394,"payloadSize":226}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:01: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2773}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:01: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.41,"linkquality":255,"power":277.3,"state":"ON","voltage":232.68}'
Zigbee2MQTT:debug 2022-05-14 07:39:01: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:04: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[57,211,255,73,187,110,224,150,178,118,188,54,130,142,33,60,165,154,4,144,158,56,206,215,152,0,85,39,57,19,56,35,197,191,170,240,123,222,43,218,144,16,128,241,57,55,213,199,200,34,158],"type":"Buffer"}},"commandID":0,"frameCounter":877808440,"gpdEndpoint":226,"gpdIEEEAddr":"0x389e900402b84b18","options":13394,"payloadSize":35}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:04: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[249,142,241,61,141,247,186,183,244,204,9,120,168,199,158,202,84,65,189,72,93,29,152,253,207],"type":"Buffer"}},"commandID":0,"frameCounter":877808670,"gpdEndpoint":226,"gpdIEEEAddr":"0x1d5d48bd02b84b58","options":13394,"payloadSize":120}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:05: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:07: Received Zigbee message from 'Hus Motion Sensor 1', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:39:07: Device 'Hus Motion Sensor 1' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:39:09: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2800,"rmsVoltage":23315}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:09: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.41,"linkquality":255,"power":280,"state":"ON","voltage":233.15}'
Zigbee2MQTT:debug 2022-05-14 07:39:09: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[183,42,80,215,13,243,102,66,90,151,246,246,177,14,52,182,50,115,83,222,197,203,37,177,107,207,141,200,75,19,125,228,252,12,94,27,196,104,118,223,251,91,159,214,31,198,140,61,49,203,253],"type":"Buffer"}},"commandID":0,"frameCounter":877809208,"gpdEndpoint":226,"gpdIEEEAddr":"0xcbc5de5302b84b18","options":13394,"payloadSize":90}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:09: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[150,111,22,229,58,210,221,124,31,242,140,219,83,128,33,242,41,7,249,87,44,34,123,184,183],"type":"Buffer"}},"commandID":0,"frameCounter":877809438,"gpdEndpoint":226,"gpdIEEEAddr":"0x222c57f902b84b58","options":13394,"payloadSize":102}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:10: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:17: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2765}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:17: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.41,"linkquality":255,"power":276.5,"state":"ON","voltage":233.15}'
Zigbee2MQTT:debug 2022-05-14 07:39:17: Received Zigbee message from 'Hus Motion Sensor 1', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:39:17: Device 'Hus Motion Sensor 1' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:39:18: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[101,162,7,172,141,102,96,73,116,155,33,75,82,193,69,224,202,140,99,232,27,37,206,129,155,35,255,1,15,201,254,30,150,210,84,13,36,229,168,226,27,144,201,5,109,109,68,58,132,190,246],"type":"Buffer"}},"commandID":0,"frameCounter":877810744,"gpdEndpoint":226,"gpdIEEEAddr":"0x251be86302b84b18","options":13394,"payloadSize":168}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:18: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[156,206,144,147,40,99,140,255,176,189,76,235,219,31,152,79,43,101,79,122,92,65,133,88,202],"type":"Buffer"}},"commandID":0,"frameCounter":877810974,"gpdEndpoint":226,"gpdIEEEAddr":"0x415c7a4f02b84b58","options":13394,"payloadSize":163}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:19: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:23: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[109,189,176,46,110,177,218,114,27,35,130,96,146,84,166,186,40,140,243,225,223,5,51,105,18],"type":"Buffer"}},"commandID":0,"frameCounter":877811742,"gpdEndpoint":226,"gpdIEEEAddr":"0x05dfe1f302b84b58","options":13394,"payloadSize":76}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:23: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:24: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2590,"rmsVoltage":23301}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:24: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.41,"linkquality":255,"power":259,"state":"ON","voltage":233.01}'
Zigbee2MQTT:debug 2022-05-14 07:39:27: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[87,126,226,226,134,227,93,181,233,106,219,127,220,151,106,255,198,38,66,184,45,232,8,25,152,89,84,220,91,99,168,233,153,43,126,37,48,220,55,121,199,136,210,109,18,33,79,200,8,191,99],"type":"Buffer"}},"commandID":0,"frameCounter":877812280,"gpdEndpoint":226,"gpdIEEEAddr":"0xe82db84202b84b18","options":13394,"payloadSize":121}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:27: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[227,184,20,51,125,128,150,228,116,73,115,237,159,167,24,203,109,109,38,94,78,175,85,73,171],"type":"Buffer"}},"commandID":0,"frameCounter":877812510,"gpdEndpoint":226,"gpdIEEEAddr":"0xaf4e5e2602b84b58","options":13394,"payloadSize":55}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:30: Received Zigbee message from 'Hus Motion Sensor 2', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:39:30: Device 'Hus Motion Sensor 2' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:39:30: Check if update available for '0x001788010949f34c' (SML002)
Zigbee2MQTT:debug 2022-05-14 07:39:30: ZigbeeOTA: downloaded main index
Zigbee2MQTT:debug 2022-05-14 07:39:30: Is new image available for '0x001788010949f34c', current '{"fieldControl":0,"manufacturerCode":4107,"imageType":269,"fileVersion":1107321517}', latest meta '{"fileVersion":1107323831,"fileSize":240760,"url":"http://fds.dc1.philips.com/firmware/ZGB_100B_010D/1107323831/Sensor-ATmega_6.1.1.27575_0012.sbl-ota","sha512":"10e549c55d262b2f227b75817f6620be407f537e04ac08db4dbebdf53e8d460299a2cda248b3be13476757d61a1c79b632963c4f126cd26b7c18ea6a2ab4ac59"}'
Zigbee2MQTT:debug 2022-05-14 07:39:30: Update available for '0x001788010949f34c': YES
Zigbee2MQTT:info  2022-05-14 07:39:30: MQTT publish: topic 'zigbee2mqtt/Hus Motion Sensor 2', payload '{"battery":100,"illuminance":37952,"illuminance_lux":6239,"led_indication":null,"linkquality":191,"motion_sensitivity":"high","occupancy":false,"occupancy_timeout":0,"temperature":14.7,"update":{"state":"available"},"update_available":true}'
Zigbee2MQTT:info  2022-05-14 07:39:30: Update available for 'Hus Motion Sensor 2'
Zigbee2MQTT:info  2022-05-14 07:39:30: MQTT publish: topic 'zigbee2mqtt/bridge/log', payload '{"message":"Update available for 'Hus Motion Sensor 2'","meta":{"device":"Hus Motion Sensor 2","status":"available"},"type":"ota_update"}'
Zigbee2MQTT:debug 2022-05-14 07:39:31: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[6,93,64,163,21,49,209,22,131,228,76,80,38,19,195,92,194,188,36,215,70,232,108,165,207,27,81,193,219,16,208,181,54,51,199,147,243,218,218,146,225,59,43,64,130,251,191,212,34,152,72],"type":"Buffer"}},"commandID":0,"frameCounter":877813048,"gpdEndpoint":226,"gpdIEEEAddr":"0xe846d72402b84b18","options":13394,"payloadSize":55}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:31: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[1,139,225,201,134,32,193,40,84,130,114,246,228,241,50,223,207,37,72,38,118,1,214,207,185],"type":"Buffer"}},"commandID":0,"frameCounter":877813278,"gpdEndpoint":226,"gpdIEEEAddr":"0x0176264802b84b58","options":13394,"payloadSize":47}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:33: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2541,"rmsCurrent":133}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:33: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.33,"linkquality":255,"power":254.1,"state":"ON","voltage":233.01}'
Zigbee2MQTT:debug 2022-05-14 07:39:33: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:36: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[194,181,184,17,55,207,192,191,20,120,117,185,142,191,109,174,170,87,81,68,156,243,145,236,79,253,36,175,198,64,84,67,107,153,231,146,43,184,132,107,138,159,21,118,20,47,179,118,197,231,192],"type":"Buffer"}},"commandID":0,"frameCounter":877813816,"gpdEndpoint":226,"gpdIEEEAddr":"0xf39c445102b84b18","options":13394,"payloadSize":78}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:36: Received Zigbee message from 'Kontor Termostat', type 'attributeReport', cluster 'hvacThermostat', data '{"danfossLoadEstimate":129}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:36: MQTT publish: topic 'zigbee2mqtt/Kontor Termostat', payload '{"adaptation_run_control":null,"adaptation_run_settings":null,"adaptation_run_status":"found","algorithm_scale_factor":2,"battery":90,"day_of_week":"monday","external_measured_room_sensor":-8000,"heat_available":true,"heat_required":true,"keypad_lockout":"unlock","linkquality":255,"load_balancing_enable":false,"load_estimate":129,"load_room_mean":-8000,"local_temperature":22.1,"mounted_mode_active":false,"mounted_mode_control":false,"occupied_heating_setpoint":30,"pi_heating_demand":100,"preheat_status":null,"programming_operation_mode":"setpoint","radiator_covered":false,"regulation_setpoint_offset":null,"running_state":"heat","setpoint_change_source":"externally","system_mode":"heat","thermostat_vertical_orientation":false,"trigger_time":0,"update":{"state":"available"},"update_available":true,"viewing_direction":false,"window_open_external":false,"window_open_feature":true,"window_open_internal":"closed"}'
Zigbee2MQTT:debug 2022-05-14 07:39:37: Received Zigbee message from 'Hue Motion Sensor 3', type 'attributeReport', cluster 'msIlluminanceMeasurement', data '{"measuredValue":22859}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:37: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 3', payload '{"battery":100,"illuminance":22859,"illuminance_lux":193,"led_indication":null,"linkquality":103,"motion_sensitivity":null,"occupancy":false,"occupancy_timeout":null,"state_ep1":"OFF","temperature":25.98,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:39:37: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:39: Received Zigbee message from 'Hus Motion Sensor 2', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:39:39: Device 'Hus Motion Sensor 2' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:39:41: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2806,"rmsVoltage":23237}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:41: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.33,"linkquality":255,"power":280.6,"state":"ON","voltage":232.37}'
Zigbee2MQTT:debug 2022-05-14 07:39:41: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[39,72,65,144,5,191,34,42,163,0,21,132,145,34,101,174,205,246,245,58,173,197,235,124,150,17,214,90,217,85,206,123,217,187,228,163,3,51,155,3,57,145,175,30,53,79,17,86,40,103,204],"type":"Buffer"}},"commandID":0,"frameCounter":877814584,"gpdEndpoint":226,"gpdIEEEAddr":"0xc5ad3af502b84b18","options":13394,"payloadSize":83}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:41: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[109,194,75,104,96,23,91,108,96,193,186,85,7,144,155,33,96,224,31,99,201,76,113,226,67],"type":"Buffer"}},"commandID":0,"frameCounter":877814814,"gpdEndpoint":226,"gpdIEEEAddr":"0x4cc9631f02b84b58","options":13394,"payloadSize":103}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:42: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:46: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[148,217,104,138,114,210,188,15,177,215,56,48,61,187,174,179,23,153,108,152,37,239,4,60,84,222,243,61,36,170,4,252,78,93,222,98,255,122,107,36,178,211,120,238,192,48,6,35,69,181,114],"type":"Buffer"}},"commandID":0,"frameCounter":877815352,"gpdEndpoint":226,"gpdIEEEAddr":"0xef25986c02b84b18","options":13394,"payloadSize":166}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:46: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[7,224,24,121,178,136,26,85,223,185,73,65,41,186,162,91,176,241,90,253,116,53,142,154,150],"type":"Buffer"}},"commandID":0,"frameCounter":877815582,"gpdEndpoint":226,"gpdIEEEAddr":"0x3574fd5a02b84b58","options":13394,"payloadSize":197}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:47: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:48: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2905,"rmsCurrent":147}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:48: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.47,"linkquality":255,"power":290.5,"state":"ON","voltage":232.37}'
Zigbee2MQTT:debug 2022-05-14 07:39:49: Received Zigbee message from 'Hus Motion Sensor 2', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:39:49: Device 'Hus Motion Sensor 2' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:39:50: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[122,178,12,96,101,233,184,235,249,89,53,247,73,35,108,68,183,171,156,56,81,8,79,19,82,118,189,71,155,45,207,107,203,228,74,21,4,67,138,247,181,230,189,233,107,131,168,15,97,187,174],"type":"Buffer"}},"commandID":0,"frameCounter":877816120,"gpdEndpoint":226,"gpdIEEEAddr":"0x0851389c02b84b18","options":13394,"payloadSize":160}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:50: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[162,63,5,210,254,182,71,203,122,110,192,165,20,17,220,70,93,73,238,219,197,83,223,125,111],"type":"Buffer"}},"commandID":0,"frameCounter":877816350,"gpdEndpoint":226,"gpdIEEEAddr":"0x53c5dbee02b84b58","options":13394,"payloadSize":109}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:52: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:55: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[97,41,42,228,247,133,242,228,41,189,83,184,191,215,143,200,223,147,35,28,50,231,117,189,251,201,219,30,89,69,103,2,6,164,169,139,34,150,67,48,237,198,53,52,96,199,45,200,204,161,167],"type":"Buffer"}},"commandID":0,"frameCounter":877816888,"gpdEndpoint":226,"gpdIEEEAddr":"0xe7321c2302b84b18","options":13394,"payloadSize":214}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:55: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[58,208,102,43,45,178,75,72,165,1,157,232,4,4,132,47,55,174,165,92,32,139,238,127,108],"type":"Buffer"}},"commandID":0,"frameCounter":877817118,"gpdEndpoint":226,"gpdIEEEAddr":"0x8b205ca502b84b58","options":13394,"payloadSize":230}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:39:56: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2790,"rmsVoltage":23325}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:56: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.47,"linkquality":255,"power":279,"state":"ON","voltage":233.25}'
Zigbee2MQTT:debug 2022-05-14 07:39:59: Received Zigbee message from 'Hue Motion Sensor 1', type 'attributeReport', cluster 'msIlluminanceMeasurement', data '{"measuredValue":23752}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:39:59: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 1', payload '{"battery":100,"illuminance":23752,"illuminance_lux":237,"led_indication":null,"linkquality":135,"motion_sensitivity":null,"occupancy":false,"occupancy_timeout":null,"temperature":15.42,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:39:59: Received Zigbee message from 'Hus Motion Sensor 2', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:39:59: Device 'Hus Motion Sensor 2' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:40:00: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[52,172,116,29,91,43,71,179,113,11,17,5,132,236,173,206,111,155,250,209,27,149,126,189,239,13,217,45,164,15,83,208,227,88,124,249,145,212,2,208,226,22,134,112,140,14,218,82,1,4,92],"type":"Buffer"}},"commandID":0,"frameCounter":877817656,"gpdEndpoint":226,"gpdIEEEAddr":"0x951bd1fa02b84b18","options":13394,"payloadSize":56}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:00: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[221,90,64,113,149,133,111,195,128,5,225,175,148,80,143,179,136,121,8,229,46,45,16,55,43],"type":"Buffer"}},"commandID":0,"frameCounter":877817886,"gpdEndpoint":226,"gpdIEEEAddr":"0x2d2ee50802b84b58","options":13394,"payloadSize":51}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:00: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:05: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2812,"rmsCurrent":143}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:05: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.43,"linkquality":255,"power":281.2,"state":"ON","voltage":233.25}'
Zigbee2MQTT:debug 2022-05-14 07:40:05: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[207,143,29,73,82,106,11,227,189,88,171,97,127,135,73,167,209,114,57,64,106,23,19,111,174,89,59,35,42,237,13,253,159,207,37,45,250,129,71,36,63,134,120,1,208,74,210,220,144,137,158],"type":"Buffer"}},"commandID":0,"frameCounter":877818424,"gpdEndpoint":226,"gpdIEEEAddr":"0x176a403902b84b18","options":13394,"payloadSize":49}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:05: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[67,150,27,49,177,55,149,169,116,104,23,236,140,211,76,183,94,107,4,153,66,112,145,97,4],"type":"Buffer"}},"commandID":0,"frameCounter":877818654,"gpdEndpoint":226,"gpdIEEEAddr":"0x7042990402b84b58","options":13394,"payloadSize":6}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:05: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:09: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[255,9,57,36,43,67,226,108,100,247,28,140,38,55,136,22,203,104,90,73,57,238,199,40,84,142,225,245,68,62,23,187,215,193,193,88,134,146,194,123,77,11,95,184,23,2,30,78,21,148,226],"type":"Buffer"}},"commandID":0,"frameCounter":877819192,"gpdEndpoint":226,"gpdIEEEAddr":"0xee39495a02b84b18","options":13394,"payloadSize":62}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:09: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[13,60,52,246,53,249,88,234,162,77,57,164,48,244,153,40,203,219,2,57,199,158,95,153,17],"type":"Buffer"}},"commandID":0,"frameCounter":877819422,"gpdEndpoint":226,"gpdIEEEAddr":"0x9ec7390202b84b58","options":13394,"payloadSize":183}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:09: Received Zigbee message from 'Hus Motion Sensor 2', type 'commandQueryNextImageRequest', cluster 'genOta', data '{"fieldControl":0,"fileVersion":1107321517,"imageType":269,"manufacturerCode":4107}' from endpoint 2 with groupID null
Zigbee2MQTT:debug 2022-05-14 07:40:09: Device 'Hus Motion Sensor 2' requested OTA
Zigbee2MQTT:debug 2022-05-14 07:40:10: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:12: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"rmsVoltage":23293}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:12: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.43,"linkquality":255,"power":281.2,"state":"ON","voltage":232.93}'
Zigbee2MQTT:debug 2022-05-14 07:40:13: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[201,119,54,51,84,31,205,62,240,74,188,79,57,98,52,110,242,43,103,101,28,60,122,25,200,117,85,60,214,229,38,94,46,255,98,112,147,160,164,216,94,94,214,136,93,93,254,16,171,143,63],"type":"Buffer"}},"commandID":0,"frameCounter":877819960,"gpdEndpoint":226,"gpdIEEEAddr":"0x3c1c656702b84b18","options":13394,"payloadSize":153}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:13: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[60,160,236,117,148,228,31,228,233,60,79,83,31,84,198,83,194,97,245,145,161,243,158,94,222],"type":"Buffer"}},"commandID":0,"frameCounter":877820190,"gpdEndpoint":226,"gpdIEEEAddr":"0xf3a191f502b84b58","options":13394,"payloadSize":103}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:14: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:18: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[194,158,200,148,216,78,95,249,17,159,220,164,237,243,4,131,15,242,137,37,118,237,110,149,116,212,43,201,252,75,147,133,185,190,112,10,207,224,232,111,147,49,92,56,63,150,75,32,125,60,27],"type":"Buffer"}},"commandID":0,"frameCounter":877820728,"gpdEndpoint":226,"gpdIEEEAddr":"0xed76258902b84b18","options":13394,"payloadSize":149}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:18: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[34,205,48,162,75,67,191,42,198,106,149,52,140,220,109,92,138,37,95,230,8,6,132,115,195],"type":"Buffer"}},"commandID":0,"frameCounter":877820958,"gpdEndpoint":226,"gpdIEEEAddr":"0x0608e65f02b84b58","options":13394,"payloadSize":86}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:18: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:20: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2511,"rmsCurrent":132}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:20: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.32,"linkquality":255,"power":251.1,"state":"ON","voltage":232.93}'
Zigbee2MQTT:debug 2022-05-14 07:40:22: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[16,200,23,168,138,133,216,57,137,8,4,9,180,215,73,144,180,38,61,45,23,114,0,252,10,18,65,122,214,222,200,146,216,152,230,114,97,27,252,239,49,119,55,73,239,63,199,156,155,185,28],"type":"Buffer"}},"commandID":0,"frameCounter":877821496,"gpdEndpoint":226,"gpdIEEEAddr":"0x72172d3d02b84b18","options":13394,"payloadSize":110}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:22: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[115,64,247,56,164,152,53,6,91,14,213,191,199,198,253,42,178,240,114,149,150,208,243,138,121],"type":"Buffer"}},"commandID":0,"frameCounter":877821726,"gpdEndpoint":226,"gpdIEEEAddr":"0xd096957202b84b58","options":13394,"payloadSize":161}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:23: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:27: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[114,170,39,223,229,236,188,48,66,241,181,146,92,84,73,129,66,17,221,1,55,175,237,196,234],"type":"Buffer"}},"commandID":0,"frameCounter":877822494,"gpdEndpoint":226,"gpdIEEEAddr":"0xaf3701dd02b84b58","options":13394,"payloadSize":172}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:27: Received Zigbee message from 'Kontor Termostat', type 'attributeReport', cluster 'hvacThermostat', data '{"localTemp":2176}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:27: MQTT publish: topic 'zigbee2mqtt/Kontor Termostat', payload '{"adaptation_run_control":null,"adaptation_run_settings":null,"adaptation_run_status":"found","algorithm_scale_factor":2,"battery":90,"day_of_week":"monday","external_measured_room_sensor":-8000,"heat_available":true,"heat_required":true,"keypad_lockout":"unlock","linkquality":255,"load_balancing_enable":false,"load_estimate":129,"load_room_mean":-8000,"local_temperature":21.76,"mounted_mode_active":false,"mounted_mode_control":false,"occupied_heating_setpoint":30,"pi_heating_demand":100,"preheat_status":null,"programming_operation_mode":"setpoint","radiator_covered":false,"regulation_setpoint_offset":null,"running_state":"heat","setpoint_change_source":"externally","system_mode":"heat","thermostat_vertical_orientation":false,"trigger_time":0,"update":{"state":"available"},"update_available":true,"viewing_direction":false,"window_open_external":false,"window_open_feature":true,"window_open_internal":"closed"}'
Zigbee2MQTT:debug 2022-05-14 07:40:28: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2435,"rmsVoltage":23316}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:28: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.32,"linkquality":255,"power":243.5,"state":"ON","voltage":233.16}'
Zigbee2MQTT:debug 2022-05-14 07:40:30: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[166,73,39,41,98,68,142,131,210,207,114,211,176,210,181,99,219,163,154,147,253,77,125,247,49,202,66,144,179,225,56,24,54,176,149,119,30,30,28,187,64,18,86,53,25,119,176,9,255,78,134],"type":"Buffer"}},"commandID":0,"frameCounter":877822264,"gpdEndpoint":226,"gpdIEEEAddr":"0x4dfd939a02b84b18","options":13394,"payloadSize":228}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:31: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[133,86,24,183,51,203,155,44,161,78,72,217,200,51,236,238,193,104,62,26,80,2,173,25,179,238,131,107,106,238,86,104,101,216,64,250,217,142,112,29,85,15,147,1,52,61,43,247,105,178,31],"type":"Buffer"}},"commandID":0,"frameCounter":877823032,"gpdEndpoint":226,"gpdIEEEAddr":"0x02501a3e02b84b18","options":13394,"payloadSize":116}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:31: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[88,227,149,190,56,54,247,143,146,195,186,253,221,4,109,143,214,61,63,200,160,170,226,11,2],"type":"Buffer"}},"commandID":0,"frameCounter":877823262,"gpdEndpoint":226,"gpdIEEEAddr":"0xaaa0c83f02b84b58","options":13394,"payloadSize":71}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:32: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:35: Received Zigbee message from 'Hus Motion Sensor 2', type 'attributeReport', cluster 'msIlluminanceMeasurement', data '{"measuredValue":36884}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:35: MQTT publish: topic 'zigbee2mqtt/Hus Motion Sensor 2', payload '{"battery":100,"illuminance":36884,"illuminance_lux":4879,"led_indication":null,"linkquality":255,"motion_sensitivity":"high","occupancy":false,"occupancy_timeout":0,"temperature":14.7,"update":{"state":"available"},"update_available":true}'
Zigbee2MQTT:debug 2022-05-14 07:40:36: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[59,9,86,254,9,165,202,222,105,38,244,12,51,37,9,251,11,199,219,172,190,214,89,25,182,246,69,113,111,43,245,168,48,172,219,173,97,244,153,240,154,13,65,68,212,95,62,153,174,104,245],"type":"Buffer"}},"commandID":0,"frameCounter":877823800,"gpdEndpoint":226,"gpdIEEEAddr":"0xd6beacdb02b84b18","options":13394,"payloadSize":65}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:36: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[49,242,14,65,226,113,167,134,37,10,12,19,253,121,39,184,145,252,121,133,118,225,254,208,248],"type":"Buffer"}},"commandID":0,"frameCounter":877824030,"gpdEndpoint":226,"gpdIEEEAddr":"0xe176857902b84b58","options":13394,"payloadSize":198}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:36: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2409,"rmsCurrent":128}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:36: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.28,"linkquality":255,"power":240.9,"state":"ON","voltage":233.16}'
Zigbee2MQTT:debug 2022-05-14 07:40:36: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:41: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[62,205,126,48,240,31,154,90,27,75,106,57,73,14,116,74,169,100,64,211,224,135,137,26,209,209,26,140,243,147,113,162,153,165,130,197,1,249,47,226,38,91,240,194,70,102,47,211,59,240,180],"type":"Buffer"}},"commandID":0,"frameCounter":877824568,"gpdEndpoint":226,"gpdIEEEAddr":"0x87e0d34002b84b18","options":13394,"payloadSize":253}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:41: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[133,179,126,71,44,201,232,240,22,91,36,169,26,186,38,33,156,231,116,175,10,62,211,191,240],"type":"Buffer"}},"commandID":0,"frameCounter":877824798,"gpdEndpoint":226,"gpdIEEEAddr":"0x3e0aaf7402b84b58","options":13394,"payloadSize":96}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:41: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:44: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2421,"rmsVoltage":23271}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:44: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.28,"linkquality":255,"power":242.1,"state":"ON","voltage":232.71}'
Zigbee2MQTT:debug 2022-05-14 07:40:45: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[251,250,203,152,89,21,204,127,87,231,105,104,151,31,202,193,220,158,137,64,38,90,113,76,203,141,131,69,178,250,0,155,124,207,73,98,25,101,119,231,216,101,198,26,161,112,47,44,45,110,107],"type":"Buffer"}},"commandID":0,"frameCounter":877825336,"gpdEndpoint":226,"gpdIEEEAddr":"0x5a26408902b84b18","options":13394,"payloadSize":19}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:45: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[201,176,179,51,133,140,162,57,191,245,233,151,186,96,103,77,130,143,76,243,160,46,40,145,153],"type":"Buffer"}},"commandID":0,"frameCounter":877825566,"gpdEndpoint":226,"gpdIEEEAddr":"0x2ea0f34c02b84b58","options":13394,"payloadSize":116}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:46: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:50: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[160,254,27,50,187,246,128,221,26,132,206,86,172,31,223,215,213,1,157,166,7,31,64,6,141,191,248,65,23,27,70,233,96,74,25,47,130,44,208,13,44,107,148,196,53,82,248,77,109,135,7],"type":"Buffer"}},"commandID":0,"frameCounter":877826104,"gpdEndpoint":226,"gpdIEEEAddr":"0x1f07a69d02b84b18","options":13394,"payloadSize":104}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:50: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[99,164,61,40,184,203,58,188,14,176,44,106,191,99,211,19,194,28,76,247,78,94,204,155,231],"type":"Buffer"}},"commandID":0,"frameCounter":877826334,"gpdEndpoint":226,"gpdIEEEAddr":"0x5e4ef74c02b84b58","options":13394,"payloadSize":190}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:50: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:52: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2412,"rmsCurrent":129}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:52: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.29,"linkquality":255,"power":241.2,"state":"ON","voltage":232.71}'
Zigbee2MQTT:debug 2022-05-14 07:40:55: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[53,104,169,81,250,200,189,73,131,231,40,179,230,252,177,216,13,44,122,98,35,237,78,102,32,82,192,164,177,24,182,247,180,61,87,40,226,152,76,38,97,206,233,236,148,41,72,250,183,247,6],"type":"Buffer"}},"commandID":0,"frameCounter":877826872,"gpdEndpoint":226,"gpdIEEEAddr":"0xed23627a02b84b18","options":13394,"payloadSize":72}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:55: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[45,99,12,21,170,113,145,72,210,162,141,174,220,224,112,157,136,42,233,68,28,113,166,130,65],"type":"Buffer"}},"commandID":0,"frameCounter":877827102,"gpdEndpoint":226,"gpdIEEEAddr":"0x711c44e902b84b58","options":13394,"payloadSize":207}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:40:56: Received Zigbee message from 'Hue Motion Sensor 1', type 'attributeReport', cluster 'msOccupancySensing', data '{"occupancy":1}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:56: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 1', payload '{"battery":100,"illuminance":23752,"illuminance_lux":237,"led_indication":null,"linkquality":255,"motion_sensitivity":null,"occupancy":true,"occupancy_timeout":null,"temperature":15.42,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:40:56: Received Zigbee message from 'Hue Motion Sensor 1', type 'attributeReport', cluster 'msIlluminanceMeasurement', data '{"measuredValue":24495}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:40:56: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 1', payload '{"battery":100,"illuminance":24495,"illuminance_lux":281,"led_indication":null,"linkquality":255,"motion_sensitivity":null,"occupancy":true,"occupancy_timeout":null,"temperature":15.42,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:41:00: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[78,246,66,97,16,205,0,246,142,161,209,221,80,240,204,217,45,246,52,194,99,130,194,238,111,15,232,252,252,215,152,24,196,213,245,3,157,215,170,144,98,142,72,242,106,111,218,48,173,171,54],"type":"Buffer"}},"commandID":0,"frameCounter":877827640,"gpdEndpoint":226,"gpdIEEEAddr":"0x8263c23402b84b18","options":13394,"payloadSize":244}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:00: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[204,165,180,203,141,219,16,150,219,234,72,135,240,208,238,87,146,103,154,226,117,200,171,60,160],"type":"Buffer"}},"commandID":0,"frameCounter":877827870,"gpdEndpoint":226,"gpdIEEEAddr":"0xc875e29a02b84b58","options":13394,"payloadSize":139}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:00: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[46,52,226,48,161,94,16,0,0,5,0,66,5,82,57,77,52,50,1,224,66,11,48,48,52,46,48,48,48,46,52,50,52,4,224,66,15,83,77,45,50,48,52,52,50,48,49,48,56,45,76,50],"type":"Buffer"}},"commandID":48,"frameCounter":45642752,"options":4190,"payloadSize":48}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:00: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2421,"rmsVoltage":23275}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:00: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.29,"linkquality":255,"power":242.1,"state":"ON","voltage":232.75}'
Zigbee2MQTT:debug 2022-05-14 07:41:03: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[3,6,226,30,161,94,16,4,11,0,72,25,2,0,8,5,33,1,0,8,9,33,6,0,8,10,33,4,0,3,6,33,100,0],"type":"Buffer"}},"commandID":4,"frameCounter":45642752,"options":4190,"payloadSize":0}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:04: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[93,35,3,12,251,69,244,92,107,166,40,42,183,91,228,8,99,106,167,187,219,158,44,253,48,84,42,125,244,180,155,179,100,207,143,98,180,61,240,233,153,169,8,179,227,44,85,189,18,191,71],"type":"Buffer"}},"commandID":0,"frameCounter":877828408,"gpdEndpoint":226,"gpdIEEEAddr":"0x9edbbba702b84b18","options":13394,"payloadSize":202}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:04: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[243,83,47,128,29,246,122,5,26,187,114,10,20,173,18,149,77,154,67,214,119,97,194,70,126],"type":"Buffer"}},"commandID":0,"frameCounter":877828638,"gpdEndpoint":226,"gpdIEEEAddr":"0x6177d64302b84b58","options":13394,"payloadSize":143}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:06: Received Zigbee message from 'Hue Motion Sensor 1', type 'attributeReport', cluster 'msIlluminanceMeasurement', data '{"measuredValue":24583}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:06: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 1', payload '{"battery":100,"illuminance":24583,"illuminance_lux":287,"led_indication":null,"linkquality":255,"motion_sensitivity":null,"occupancy":true,"occupancy_timeout":null,"temperature":15.42,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:41:08: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2410}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:08: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.29,"linkquality":255,"power":241,"state":"ON","voltage":232.75}'
Zigbee2MQTT:debug 2022-05-14 07:41:09: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[59,241,139,50,26,243,231,1,9,205,195,161,61,58,166,175,229,57,204,162,253,221,126,248,242,229,175,204,129,0,210,58,89,96,245,113,165,8,101,116,13,134,93,186,117,186,167,164,43,207,238],"type":"Buffer"}},"commandID":0,"frameCounter":877829176,"gpdEndpoint":226,"gpdIEEEAddr":"0xddfda2cc02b84b18","options":13394,"payloadSize":108}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:13: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[232,159,7,118,162,98,205,11,230,218,217,253,116,223,10,206,118,115,72,16,10,87,82,229,246,255,146,174,61,97,65,15,0,23,204,97,182,181,233,146,125,46,165,238,14,228,6,118,23,198,227],"type":"Buffer"}},"commandID":0,"frameCounter":877829944,"gpdEndpoint":226,"gpdIEEEAddr":"0x570a104802b84b18","options":13394,"payloadSize":209}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:13: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[252,108,88,190,197,93,162,74,248,157,108,102,137,147,41,114,192,224,231,98,91,214,142,17,8],"type":"Buffer"}},"commandID":0,"frameCounter":877830174,"gpdEndpoint":226,"gpdIEEEAddr":"0xd65b62e702b84b58","options":13394,"payloadSize":74}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:16: Received Zigbee message from 'Hue Motion Sensor 1', type 'attributeReport', cluster 'msOccupancySensing', data '{"occupancy":0}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:16: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 1', payload '{"battery":100,"illuminance":24583,"illuminance_lux":287,"led_indication":null,"linkquality":255,"motion_sensitivity":null,"occupancy":false,"occupancy_timeout":null,"temperature":15.42,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:41:16: Received Zigbee message from 'Hue Motion Sensor 1', type 'attributeReport', cluster 'msIlluminanceMeasurement', data '{"measuredValue":24912}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:16: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 1', payload '{"battery":100,"illuminance":24912,"illuminance_lux":310,"led_indication":null,"linkquality":255,"motion_sensitivity":null,"occupancy":false,"occupancy_timeout":null,"temperature":15.42,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:41:16: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2520,"rmsVoltage":23222}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:16: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.29,"linkquality":255,"power":252,"state":"ON","voltage":232.22}'
Zigbee2MQTT:debug 2022-05-14 07:41:18: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[58,53,128,47,180,136,82,77,200,61,201,246,24,153,129,250,143,207,137,70,108,200,64,106,180,163,81,202,55,39,224,188,70,121,253,99,67,94,75,11,30,202,206,174,157,32,232,197,193,144,4],"type":"Buffer"}},"commandID":0,"frameCounter":877830712,"gpdEndpoint":226,"gpdIEEEAddr":"0xc86c468902b84b18","options":13394,"payloadSize":200}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:18: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[73,99,97,51,86,114,39,164,136,69,198,64,94,64,94,23,48,94,171,87,156,187,167,113,212],"type":"Buffer"}},"commandID":0,"frameCounter":877830942,"gpdEndpoint":226,"gpdIEEEAddr":"0xbb9c57ab02b84b58","options":13394,"payloadSize":27}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:22: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[230,95,165,193,56,148,146,35,188,251,128,255,163,188,152,100,7,225,99,216,171,248,128,199,225,116,49,77,180,64,124,223,27,22,154,104,206,98,219,227,71,83,10,231,98,224,140,16,189,188,201],"type":"Buffer"}},"commandID":0,"frameCounter":877831480,"gpdEndpoint":226,"gpdIEEEAddr":"0xf8abd86302b84b18","options":13394,"payloadSize":226}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:22: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[55,41,186,75,60,157,90,197,188,85,20,71,217,144,138,191,191,34,255,169,92,208,245,12,191],"type":"Buffer"}},"commandID":0,"frameCounter":877831710,"gpdEndpoint":226,"gpdIEEEAddr":"0xd05ca9ff02b84b58","options":13394,"payloadSize":248}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:23: Received MQTT message on 'zigbee2mqtt/bridge/request/permit_join' with data '{"device":null,"time":254,"transaction":"xnjuc-1","value":true}'
Zigbee2MQTT:info  2022-05-14 07:41:23: Zigbee: allowing new devices to join.
Zigbee2MQTT:info  2022-05-14 07:41:23: MQTT publish: topic 'zigbee2mqtt/bridge/response/permit_join', payload '{"data":{"time":254,"value":true},"status":"ok","transaction":"xnjuc-1"}'
Zigbee2MQTT:debug 2022-05-14 07:41:24: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2476,"rmsCurrent":131}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:24: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.31,"linkquality":255,"power":247.6,"state":"ON","voltage":232.22}'
Zigbee2MQTT:debug 2022-05-14 07:41:26: Received Zigbee message from 'Røgalarm 1', type 'commandStatusChangeNotification', cluster 'ssIasZone', data '{"extendedstatus":0,"zonestatus":48}' from endpoint 35 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:26: MQTT publish: topic 'zigbee2mqtt/Røgalarm 1', payload '{"alarm":null,"battery":100,"battery_low":false,"enrolled":true,"fault":false,"ias_cie_address":"0x00212effff075c44","linkquality":255,"max_duration":240,"reliability":"no_fault_detected","restore_reports":true,"smoke":false,"supervision_reports":true,"temperature":18.81,"test":false,"update":{"state":"idle"},"update_available":false,"voltage":3000,"zone_id":23}'
Zigbee2MQTT:debug 2022-05-14 07:41:27: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[165,189,47,174,45,250,134,85,140,149,197,189,227,119,204,81,59,75,139,150,238,81,102,152,66,234,235,107,76,177,250,93,78,147,181,21,187,230,11,217,36,50,76,206,26,229,84,233,25,19,126],"type":"Buffer"}},"commandID":0,"frameCounter":877832248,"gpdEndpoint":226,"gpdIEEEAddr":"0x51ee968b02b84b18","options":13394,"payloadSize":190}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:27: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[125,27,82,81,21,158,228,169,77,232,93,242,120,81,165,185,21,216,222,204,254,87,157,46,181],"type":"Buffer"}},"commandID":0,"frameCounter":877832478,"gpdEndpoint":226,"gpdIEEEAddr":"0x57feccde02b84b58","options":13394,"payloadSize":163}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:29: Received Zigbee message from 'Hue Motion Sensor 1', type 'attributeReport', cluster 'msOccupancySensing', data '{"occupancy":1}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:29: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 1', payload '{"battery":100,"illuminance":24912,"illuminance_lux":310,"led_indication":null,"linkquality":255,"motion_sensitivity":null,"occupancy":true,"occupancy_timeout":null,"temperature":15.42,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:41:29: Received Zigbee message from 'Hue Motion Sensor 1', type 'attributeReport', cluster 'msIlluminanceMeasurement', data '{"measuredValue":25908}' from endpoint 2 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:29: MQTT publish: topic 'zigbee2mqtt/Hue Motion Sensor 1', payload '{"battery":100,"illuminance":25908,"illuminance_lux":390,"led_indication":null,"linkquality":255,"motion_sensitivity":null,"occupancy":true,"occupancy_timeout":null,"temperature":15.42,"update":{"state":"idle"},"update_available":false}'
Zigbee2MQTT:debug 2022-05-14 07:41:32: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[150,34,78,85,131,114,187,79,210,46,115,68,152,137,184,240,164,255,227,26,147,226,234,47,57,115,141,125,145,55,68,64,131,172,198,251,201,160,189,220,180,54,49,155,120,36,249,169,225,233,163],"type":"Buffer"}},"commandID":0,"frameCounter":877833016,"gpdEndpoint":226,"gpdIEEEAddr":"0xe2931ae302b84b18","options":13394,"payloadSize":151}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:32: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[232,156,192,254,52,68,8,184,201,114,75,8,91,142,220,133,153,66,151,0,34,2,250,68,44],"type":"Buffer"}},"commandID":0,"frameCounter":877833246,"gpdEndpoint":226,"gpdIEEEAddr":"0x0222009702b84b58","options":13394,"payloadSize":90}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:32: Received Zigbee message from 'Strømmålende Stikkontakt', type 'attributeReport', cluster 'haElectricalMeasurement', data '{"activePower":2472,"rmsVoltage":23207}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:32: MQTT publish: topic 'zigbee2mqtt/Strømmålende Stikkontakt', payload '{"current":1.31,"linkquality":255,"power":247.2,"state":"ON","voltage":232.07}'
Zigbee2MQTT:debug 2022-05-14 07:41:33: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[163,12,243,204,146,134,209,8,215,253,176,209,194,161,253,184,97,118,178,0,161,142,77,188,151,15,77,68,167,90,5,222,52],"type":"Buffer"}},"commandID":0,"frameCounter":877833766,"gpdEndpoint":226,"gpdIEEEAddr":"0x8ea100b202b84b18","options":13394,"payloadSize":165}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:37: Received Zigbee message from 'Aqara Sensor', type 'attributeReport', cluster 'msTemperatureMeasurement', data '{"measuredValue":2212}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:37: MQTT publish: topic 'zigbee2mqtt/Aqara Sensor', payload '{"battery":100,"humidity":52.2,"linkquality":255,"pressure":1009.3,"temperature":22.12,"voltage":3025}'
Zigbee2MQTT:debug 2022-05-14 07:41:37: Received Zigbee message from 'Aqara Sensor', type 'attributeReport', cluster 'msRelativeHumidity', data '{"measuredValue":5203}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:37: MQTT publish: topic 'zigbee2mqtt/Aqara Sensor', payload '{"battery":100,"humidity":52.03,"linkquality":255,"pressure":1009.3,"temperature":22.12,"voltage":3025}'
Zigbee2MQTT:debug 2022-05-14 07:41:37: Received Zigbee message from 'Aqara Sensor', type 'attributeReport', cluster 'msPressureMeasurement', data '{"measuredValue":1009,"scale":-1,"scaledValue":10099}' from endpoint 1 with groupID null
Zigbee2MQTT:info  2022-05-14 07:41:37: MQTT publish: topic 'zigbee2mqtt/Aqara Sensor', payload '{"battery":100,"humidity":52.03,"linkquality":255,"pressure":1009.9,"temperature":22.12,"voltage":3025}'
Zigbee2MQTT:debug 2022-05-14 07:41:39: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[117,156,226,56,18,83,52,0,133,87,21,5,19,232,32,61,225,50,142,5,221,46,13,52,232,12,45,57,57,117,156,6,15,111,138,3,23,33,221,205,166,86,183,125,64,114,71,72,14,222,234,247,157,85,226,220,3,77,35,131],"type":"Buffer"}},"commandID":57,"frameCounter":45632280,"options":13395,"payloadSize":57}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:41: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,20,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":20}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:45: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,24,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":24}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:46: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,25,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":25}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:48: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,27,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":27}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:50: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,28,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":28}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:51: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,29,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":29}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:54: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,32,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":32}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:41:55: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,33,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":33}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:42:27: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[117,156,226,56,18,83,52,0,133,87,21,5,19,232,32,61,225,50,142,5,221,46,13,52,232,12,45,57,57,117,156,6,15,111,138,3,23,33,221,205,166,86,183,125,64,114,71,72,14,222,234,247,157,85,226,220,3,77,35,131],"type":"Buffer"}},"commandID":57,"frameCounter":45632280,"options":13395,"payloadSize":57}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:42:31: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,19,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":19}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:42:32: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,20,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":20}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:42:33: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,21,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":21}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:42:34: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,22,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":22}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:42:35: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,23,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":23}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:42:36: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,24,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":24}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Zigbee2MQTT:debug 2022-05-14 07:42:37: Received Zigbee message from 'Coordinator', type 'commandCommisioningNotification', cluster 'greenPower', data '{"commandFrame":{"raw":{"data":[83,52,226,53,224,254,231,243,66,72,222,175,72,98,243,117,4,49,46,199,19,73,62,130,79,40,212,192,25,83,52,0,15,94,16,93,67,6,161,163,165,241,242,246,6,0,0,2,0,3,0,2,7,4,11,5,11],"type":"Buffer"}},"commandID":192,"frameCounter":45632320,"options":59390,"payloadSize":25}' from endpoint 242 with groupID 2948, ignoring since it is from coordinator
Error: Unhandled error. ('APS TIMEOUT')
    at new NodeError (node:internal/errors:372:5)
    at DeconzAdapter.emit (node:events:516:17)
    at emitUnhandledRejectionOrErr (node:events:384:10)
    at processTicksAndRejections (node:internal/process/task_queues:85:21)
    at runNextTicks (node:internal/process/task_queues:65:3)
    at listOnTimeout (node:internal/timers:528:9)
    at processTimers (node:internal/timers:502:7)
Using '/app/data' as data directory
Zigbee2MQTT:debug 2022-05-14 07:42:41: Loaded state from file /app/data/state.json
Zigbee2MQTT:info  2022-05-14 07:42:41: Logging to console and directory: '/app/data/log/2022-05-14.07-42-40' filename: log.txt
Zigbee2MQTT:debug 2022-05-14 07:42:41: Removing old log directory '/app/data/log/2022-05-13.21-02-32'
Zigbee2MQTT:info  2022-05-14 07:42:41: Starting Zigbee2MQTT version 1.25.1-dev (commit #24cfdf4)
Zigbee2MQTT:info  2022-05-14 07:42:41: Starting zigbee-herdsman (0.14.30)
Zigbee2MQTT:debug 2022-05-14 07:42:41: Using zigbee-herdsman with settings: '{"adapter":{"concurrent":null,"delay":null,"disableLED":false},"backupPath":"/app/data/coordinator_backup.json","databaseBackupPath":"/app/data/database.db.backup","databasePath":"/app/data/database.db","network":{"channelList":[11],"extendedPanID":[221,221,221,221,221,221,221,221],"networkKey":"HIDDEN","panID":6754},"serialPort":{"path":"/dev/ttyACM0"}}'
CREATED DECONZ ADAPTER
Zigbee2MQTT:info  2022-05-14 07:42:41: zigbee-herdsman started (resumed)
Zigbee2MQTT:info  2022-05-14 07:42:41: Coordinator firmware version: '{"meta":{"maintrel":0,"majorrel":38,"minorrel":104,"product":0,"revision":"0x26680700","transportrev":0},"type":"ConBee2/RaspBee2"}'
Zigbee2MQTT:debug 2022-05-14 07:42:41: Zigbee network parameters: {"channel":11,"extendedPanID":"0xdddddddddddddddd","panID":6754}
Zigbee2MQTT:info  2022-05-14 07:42:41: Currently 100 devices are joined:

@Inrego
Copy link
Author

Inrego commented May 14, 2022

I'm gonna try now with both of those GreenPower devices switched off. It's just not that feasible for longer periods of time due to the nature of their installation. It requires me to switch off the mains that they're monitoring.

@Inrego
Copy link
Author

Inrego commented May 14, 2022

Ok, I've now paired those green power devices back to their own hub. And Z2M seems to run stable again. So this issue can be closed I guess.

I'm still having lots of problems when trying to pair them to Z2M, but I guess that's another issue.

@Inrego Inrego closed this as completed May 14, 2022
@Inrego
Copy link
Author

Inrego commented May 14, 2022

Scratch that, my ZigBee network is down again.

@Inrego Inrego reopened this May 14, 2022
@ChrisHae
Copy link

ChrisHae commented May 17, 2022

There was a pull request that is related to those GP devices I think:
Koenkk/zigbee-herdsman@146997b
And there will be one more fix in the near future. Koenkk/zigbee-herdsman#536

And because of that Error: Unhandled error. ('APS TIMEOUT')
could you paste the zigbee-herdsman debug log here? See https://www.zigbee2mqtt.io/guide/usage/debug.html I would need the zigbee-herdsman debug logs to see more. Mqtt debug log is not enough in this case.

@Inrego
Copy link
Author

Inrego commented May 17, 2022

Ooh that's great news. I've also ordered another zigbee coordinator. But if a fix is coming to Conbee, I'll keep that, and maybe flash the incoming one with sniffer firmware for other purposes.

Thanks for linking to how to enable herdsman log output. I was looking for it in settings, without luck.

Lets put a pin in this issue and wait and see if I'm still having issues with above changes.

@github-actions
Copy link
Contributor

This issue is stale because it has been open 30 days with no activity. Remove stale label or comment or this will be closed in 7 days

@github-actions github-actions bot added the stale Stale issues label Jun 17, 2022
@nebhead
Copy link

nebhead commented Jun 17, 2022

FYI... with version 1.25.2-dev commit: e525919 I am no longer seeing crashes every 2-7 days.

@github-actions github-actions bot removed the stale Stale issues label Jun 18, 2022
@github-actions
Copy link
Contributor

This issue is stale because it has been open 30 days with no activity. Remove stale label or comment or this will be closed in 7 days

@github-actions github-actions bot added the stale Stale issues label Jul 18, 2022
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
problem Something isn't working stale Stale issues
Projects
None yet
Development

No branches or pull requests

8 participants