deCONZ switch between online and offline after updating to Openhab 4.01

sendtom · August 27, 2023, 4:00pm

Yes, the API key is correct, I was able to send a request via Postman without any problems.
I don’t think it’s the API key, otherwise the gateway would be offline all the time. The gateway is offline only every 120 seconds.
Here is my log:

2023-08-27 17:54:26.801 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:deconz:f0f10192f5’ changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 120s. Websocket seems to be dead.

2023-08-27 17:54:26.801 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:presencesensor:f0f10192f5:00158d0007e2f073010406’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:26.802 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:humiditysensor:f0f10192f5:00158d000950d82a010405’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:26.802 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:temperaturesensor:f0f10192f5:00158d000950d82a010402’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:26.802 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:humiditysensor:f0f10192f5:00158d0007e488f3010405’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:26.802 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:lightsensor:f0f10192f5:00158d0007e2f073010400’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:26.802 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:temperaturesensor:f0f10192f5:00158d0007e3dd45010402’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:26.802 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:humiditysensor:f0f10192f5:00158d000708492b010405’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:26.803 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:humiditysensor:f0f10192f5:00158d0007e3dd45010405’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:26.803 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:temperaturesensor:f0f10192f5:00158d0007e488f3010402’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:26.803 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:temperaturesensor:f0f10192f5:00158d000708492b010402’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

2023-08-27 17:54:36.907 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing ‘deconz:deconz:f0f10192f5’ changed from OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 120s. Websocket seems to be dead. to ONLINE

OMR · August 27, 2023, 5:33pm

Have you checked top?
OH4.0.1 had a cpu hog issue…
Fixed in 4.0.2

sendtom · August 28, 2023, 8:55am

The CPU hog is known to me. But is not the cause of my problem with deconz, because I am already on openhab 4.0.2 and this CPU hog has been fixed.

OMR · August 28, 2023, 10:01am

Then I’m out of ideas, other than enabling logging in deconz for more clues…

sendtom · August 29, 2023, 11:42am

so the log from deconz also shows problems with the wegsocket. Here is an extract of it:
12:09:53:969 Websocket disconnected 10.15.4.240:50908, state: 0, close-code: 1001, reason: Shutdown

and here the log part1:

12:07:20:415 HTTP Server listen on address 0.0.0.0, port: 80, root: /usr/share/deCONZ/webapp/
12:07:20:463 /home/pi/.local/share/dresden-elektronik/deCONZ/config.ini exists and is writeable
12:07:20:463 /home/pi/.local/share/dresden-elektronik/deCONZ/zll.db exists and is writeable
12:07:21:230 COM: /dev/ttyAMA0 :  (0x0000/0x0000)
12:07:21:231 COM: /dev/ttyS0 :  (0x0000/0x0000)
12:07:21:232 dev /dev/ttyS0 (/dev/ttyS0)
12:07:21:233 ZCLDB init file /home/pi/.local/share/dresden-elektronik/deCONZ/zcldb.txt
12:07:21:500 void deCONZ::ZclDataBase::load(const QString&),3392: assertion 'val <= nt->max' failed
12:07:21:500 void deCONZ::ZclDataBase::load(const QString&),3392: assertion 'val <= nt->max' failed
12:07:21:502 void deCONZ::ZclDataBase::load(const QString&),3392: assertion 'val <= nt->max' failed
12:07:21:502 void deCONZ::ZclDataBase::load(const QString&),3392: assertion 'val <= nt->max' failed
12:07:21:502 void deCONZ::ZclDataBase::load(const QString&),3392: assertion 'val <= nt->max' failed
12:07:21:502 void deCONZ::ZclDataBase::load(const QString&),3392: assertion 'val <= nt->max' failed
12:07:21:662 void deCONZ::ZclDataBase::load(const QString&),3391: assertion 'val >= nt->min' failed
12:07:22:239 DDF enabled for Gold status
12:07:26:367 parent process -bash
12:07:26:368 gw run mode: normal
12:07:26:368 GW sd-card image version file does not exist: /home/pi/.local/share/dresden-elektronik/deCONZ/gw-version
12:07:26:369 sd-card cid: 1b534d454538515430ffffffff012ba3
12:07:26:376 DB sqlite version 3.34.1
12:07:26:382 DB PRAGMA page_count: 57
12:07:26:382 DB PRAGMA page_size: 4096
12:07:26:383 DB PRAGMA freelist_count: 1
12:07:26:383 DB file size 233472 bytes, free pages 1
12:07:26:383 DB PRAGMA user_version: 9
12:07:26:383 DB cleanup
12:07:26:388 DB create temporary views
12:07:26:390 DB view [0] created
12:07:26:393 DB view [1] created
12:07:26:395 DB view [2] created
12:07:26:397 DB view [3] created
12:07:26:398 sql exec SELECT apikey,devicetype,createdate,lastusedate,useragent FROM auth
12:07:26:473 sql exec SELECT key FROM config2
12:07:26:474 sql exec SELECT key,value FROM config2
12:07:26:475 Load config UTC: 2023-08-29T08:48:53 from db.
12:07:26:475 Load config announceinterval: 0 from db.
12:07:26:475 Load config announceurl: https://phoscon.de/discover from db.
12:07:26:475 Load config apiversion: 2.22.02 from db.
12:07:26:475 Load config bridgeid: 00212EFFFF0A5215 from db.
12:07:26:476 Load config datastoreversion: 93 from db.
12:07:26:476 Load config dhcp: true from db.
12:07:26:476 Load config disablePermitJoinAutoOff: false from db.
12:07:26:476 Load config discovery: false from db.
12:07:26:476 Load config factorynew: false from db.
12:07:26:476 Load config fwneedupdate: false from db.
12:07:26:476 Load config fwupdatestate: idle from db.
12:07:26:476 Load config fwversion: 0x26690700 from db.
12:07:26:476 Load config gateway: 127.0.0.1 from db.
12:07:26:477 Load config group0: 65520 from db.
12:07:26:477 Load config groupdelay: 50 from db.
12:07:26:477 Load config gwpassword: $1$8282jdkm$ASseeCbkW.X.6UHWdRVg5/ from db.
12:07:26:477 Load config gwusername: delight from db.
12:07:26:477 Load config homebridge: not-managed from db.
12:07:26:477 Load config homebridge-pin:  from db.
12:07:26:477 Load config homebridgepin:  from db.
12:07:26:477 Load config homebridgeupdate: false from db.
12:07:26:478 Load config homebridgeupdateversion:  from db.
12:07:26:478 Load config homebridgeversion:  from db.
12:07:26:478 Load config ipaddress: 10.15.5.9 from db.
12:07:26:478 Load config lightlastseeninterval: 60 from db.
12:07:26:478 Load config linkbutton: false from db.
12:07:26:478 Load config localtime: 2023-08-29T09:48:53 from db.
12:07:26:478 Load config mac: 38:60:77:7c:53:18 from db.
12:07:26:478 Load config modelid: deCONZ from db.
12:07:26:478 Load config name: DeconzSchlafz from db.
12:07:26:479 Load config netmask: 255.0.0.0 from db.
12:07:26:479 Load config networkopenduration: 180 from db.
12:07:26:479 Load config otauactive: false from db.
12:07:26:479 Load config otaustate: off from db.
12:07:26:479 Load config panid: 0 from db.
12:07:26:479 Load config permitjoin: 0 from db.
12:07:26:479 Load config permitjoinfull: 0 from db.
12:07:26:479 Load config port: 80 from db.
12:07:26:479 Load config portalservices: false from db.
12:07:26:479 Load config proxyaddress: none from db.
12:07:26:480 Load config proxyport: 0 from db.
12:07:26:480 Load config rfconnect: 1 from db.
12:07:26:480 Load config rfconnected: false from db.
12:07:26:480 Load config rgbwdisplay: 1 from db.
12:07:26:480 Load config runmode: systemd/headless from db.
12:07:26:480 Load config starterkitid:  from db.
12:07:26:480 Load config swcommit: ce3299e640c0a655fc15a61896f5c7e24c0cc81a from db.
12:07:26:480 Load config swupdatestate: noupdates from db.
12:07:26:480 Load config swversion: 2.22.02 from db.
12:07:26:481 Load config system: linux-gw from db.
12:07:26:481 Load config timeformat: 24h from db.
12:07:26:481 Load config timezone: Europe/Zurich from db.
12:07:26:481 Load config updatechannel: stable from db.
12:07:26:481 Load config uuid: 01a3f748-0fcb-47d7-9b7f-595ae0cdde07 from db.
12:07:26:481 Load config websocketnotifyall: true from db.
12:07:26:481 Load config websocketport: 443 from db.
12:07:26:482 Load config wifi: not-configured from db.
12:07:26:482 Load config wifibackupname:  from db.
12:07:26:482 Load config wifibackuppw:  from db.
12:07:26:482 Load config wifibackuppwenc:  from db.
12:07:26:482 Load config wifichannel: 1 from db.
12:07:26:482 Load config wificlientname: IOT from db.
12:07:26:482 Load config wificlientpw:  from db.
12:07:26:482 Load config wifiip: 10.15.5.9 from db.
12:07:26:482 Load config wifilastupdated: 0 from db.
12:07:26:482 Load config wifimgmt: 0 from db.
12:07:26:483 Load config wifiname:  from db.
12:07:26:483 Load config wifipageactive: false from db.
12:07:26:483 Load config wifipw:  from db.
12:07:26:483 Load config wifipwenc:  from db.
12:07:26:483 Load config wifitype: accesspoint from db.
12:07:26:483 Load config workingname: IOT from db.
12:07:26:483 Load config workingpw:  from db.
12:07:26:483 Load config workingpwenc:  from db.
12:07:26:483 Load config workingtype: client from db.
12:07:26:483 Load config zclvaluemaxage: 0 from db.
12:07:26:484 Load config zigbeechannel: 11 from db.
12:07:26:484 sql exec SELECT key,value FROM userparameter
12:07:26:485 sql exec SELECT * FROM groups
12:07:26:487 Sqlite group: gid = 0xFFF0
12:07:26:487 Sqlite group: name = All
12:07:26:487 Sqlite group: state = normal
12:07:26:487 Sqlite group: hidden = false
12:07:26:487 Sqlite group: type = LightGroup
12:07:26:488 Sqlite group: class = Other
12:07:26:488 DB found group All 0xFFF0
12:07:26:489 sql exec SELECT * FROM resourcelinks
12:07:26:490 sql exec SELECT * FROM scenes
12:07:26:491 sql exec SELECT * FROM rules
12:07:26:492 sql exec SELECT * FROM schedules
12:07:26:493 sql exec SELECT * FROM sensors
12:07:26:495 Sqlite sensors: sid = 1
12:07:26:495 Sqlite sensors: name = Daylight
12:07:26:495 Sqlite sensors: type = Daylight
12:07:26:496 Sqlite sensors: modelid = PHDL00
12:07:26:496 Sqlite sensors: manufacturername = Philips
12:07:26:496 Sqlite sensors: uniqueid = 00:21:2e:ff:ff:0a:52:15-01
12:07:26:497 Sqlite sensors: swversion = 1.0
12:07:26:497 Sqlite sensors: state = {"dark":false,"daylight":true,"lastupdated":"2023-08-29T09:01:21.068","status":160,"sunrise":"2023-08-29T04:41:25","sunset":"2023-08-29T18:15:22"}
12:07:26:497 Sqlite sensors: config = {"configured":true,"lat":"47.3664","long":"8.5546","on":true,"sunriseoffset":30,"sunsetoffset":-30}
12:07:26:497 Sqlite sensors: deletedState = normal
12:07:26:498 Sqlite sensors: mode = 1
12:07:26:498 DB found sensor Daylight 1
12:07:26:503 Sqlite sensors: sid = 13
12:07:26:503 Sqlite sensors: name = MultisensorSchlafzimmer
12:07:26:503 Sqlite sensors: type = ZHATemperature
12:07:26:504 Sqlite sensors: modelid = lumi.weather
12:07:26:504 Sqlite sensors: manufacturername = LUMI
12:07:26:504 Sqlite sensors: uniqueid = 00:15:8d:00:09:50:d8:2a-01-0402
12:07:26:504 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:505 Sqlite sensors: state = {"lastupdated":"2023-08-29T08:59:22.897","temperature":2448,"temperature_bis":null}
12:07:26:505 Sqlite sensors: config = {"battery":95,"offset":0,"on":true,"reachable":false}
12:07:26:505 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1026],"p":260}
12:07:26:506 Sqlite sensors: deletedState = normal
12:07:26:506 Sqlite sensors: mode = 1
12:07:26:506 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:507 DB found sensor MultisensorSchlafzimmer 13
12:07:26:509 DB skip loading sensor MultisensorSchlafzimmer 13, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:510 Sqlite sensors: sid = 14
12:07:26:510 Sqlite sensors: name = MultisensorSchlafzimmer
12:07:26:511 Sqlite sensors: type = ZHAHumidity
12:07:26:511 Sqlite sensors: modelid = lumi.weather
12:07:26:511 Sqlite sensors: manufacturername = LUMI
12:07:26:511 Sqlite sensors: uniqueid = 00:15:8d:00:09:50:d8:2a-01-0405
12:07:26:512 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:512 Sqlite sensors: state = {"humidity":5336,"humidity_bis":null,"lastupdated":"2023-08-29T08:59:23.031"}
12:07:26:512 Sqlite sensors: config = {"battery":95,"offset":0,"on":true,"reachable":false}
12:07:26:512 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1029],"p":260}
12:07:26:513 Sqlite sensors: deletedState = normal
12:07:26:513 Sqlite sensors: mode = 1
12:07:26:513 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:514 DB found sensor MultisensorSchlafzimmer 14
12:07:26:516 DB skip loading sensor MultisensorSchlafzimmer 14, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:516 Sqlite sensors: sid = 15
12:07:26:517 Sqlite sensors: name = MultisensorSchlafzimmer
12:07:26:517 Sqlite sensors: type = ZHAPressure
12:07:26:517 Sqlite sensors: modelid = lumi.weather
12:07:26:517 Sqlite sensors: manufacturername = LUMI
12:07:26:518 Sqlite sensors: uniqueid = 00:15:8d:00:09:50:d8:2a-01-0403
12:07:26:518 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:518 Sqlite sensors: state = {"lastupdated":"2023-08-29T08:59:23.139","pressure":945,"pressure_bis":null}
12:07:26:518 Sqlite sensors: config = {"battery":95,"offset":0,"on":true,"reachable":false}
12:07:26:519 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1027],"p":260}
12:07:26:519 Sqlite sensors: deletedState = normal
12:07:26:519 Sqlite sensors: mode = 1
12:07:26:519 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:520 DB found sensor MultisensorSchlafzimmer 15
12:07:26:522 DB skip loading sensor MultisensorSchlafzimmer 15, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:523 Sqlite sensors: sid = 5
12:07:26:523 Sqlite sensors: name = MultisensorTerrasseNord
12:07:26:523 Sqlite sensors: type = ZHATemperature
12:07:26:524 Sqlite sensors: modelid = lumi.weather
12:07:26:524 Sqlite sensors: manufacturername = LUMI
12:07:26:524 Sqlite sensors: uniqueid = 00:15:8d:00:07:e4:88:f3-01-0402
12:07:26:524 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:525 Sqlite sensors: state = {"lastupdated":"2023-08-29T08:54:32.945","temperature":1602,"temperature_bis":null}
12:07:26:525 Sqlite sensors: config = {"battery":92,"offset":0,"on":true,"reachable":false}
12:07:26:525 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1026],"p":260}
12:07:26:526 Sqlite sensors: deletedState = normal
12:07:26:526 Sqlite sensors: mode = 1
12:07:26:526 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:527 DB found sensor MultisensorTerrasseNord 5
12:07:26:528 DB skip loading sensor MultisensorTerrasseNord 5, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:529 Sqlite sensors: sid = 4
12:07:26:529 Sqlite sensors: name = MultisensorTerrasseNord
12:07:26:530 Sqlite sensors: type = ZHAHumidity
12:07:26:530 Sqlite sensors: modelid = lumi.weather
12:07:26:530 Sqlite sensors: manufacturername = LUMI
12:07:26:530 Sqlite sensors: uniqueid = 00:15:8d:00:07:e4:88:f3-01-0405
12:07:26:531 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:531 Sqlite sensors: state = {"humidity":8080,"humidity_bis":null,"lastupdated":"2023-08-29T08:54:33.067"}
12:07:26:531 Sqlite sensors: config = {"battery":92,"offset":0,"on":true,"reachable":false}
12:07:26:531 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1029],"p":260}
12:07:26:532 Sqlite sensors: deletedState = normal
12:07:26:532 Sqlite sensors: mode = 1
12:07:26:532 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:533 DB found sensor MultisensorTerrasseNord 4
12:07:26:535 DB skip loading sensor MultisensorTerrasseNord 4, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:535 Sqlite sensors: sid = 6
12:07:26:536 Sqlite sensors: name = MultisensorTerrasseNord
12:07:26:536 Sqlite sensors: type = ZHAPressure
12:07:26:536 Sqlite sensors: modelid = lumi.weather
12:07:26:536 Sqlite sensors: manufacturername = LUMI
12:07:26:537 Sqlite sensors: uniqueid = 00:15:8d:00:07:e4:88:f3-01-0403
12:07:26:537 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:537 Sqlite sensors: state = {"lastupdated":"2023-08-29T08:54:33.183","pressure":948,"pressure_bis":null}
12:07:26:537 Sqlite sensors: config = {"battery":92,"offset":0,"on":true,"reachable":false}
12:07:26:537 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1027],"p":260}
12:07:26:538 Sqlite sensors: deletedState = normal
12:07:26:538 Sqlite sensors: mode = 1
12:07:26:538 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:539 DB found sensor MultisensorTerrasseNord 6
12:07:26:541 DB skip loading sensor MultisensorTerrasseNord 6, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:542 Sqlite sensors: sid = 2
12:07:26:542 Sqlite sensors: name = Bewegungsmelder
12:07:26:542 Sqlite sensors: type = ZHALightLevel
12:07:26:542 Sqlite sensors: modelid = lumi.sensor_motion.aq2
12:07:26:543 Sqlite sensors: manufacturername = LUMI
12:07:26:543 Sqlite sensors: uniqueid = 00:15:8d:00:07:e2:f0:73-01-0400
12:07:26:543 Sqlite sensors: swversion = 3000-0001
12:07:26:544 Sqlite sensors: state = {"dark":false,"daylight":false,"lastupdated":"2023-08-29T05:46:59.912","lightlevel":14625,"lux":29}
12:07:26:544 Sqlite sensors: config = {"battery":100,"on":true,"reachable":false,"tholddark":12000,"tholdoffset":7000}
12:07:26:544 Sqlite sensors: fingerprint = {"d":263,"ep":1,"in":[1024],"p":260}
12:07:26:544 Sqlite sensors: deletedState = normal
12:07:26:544 Sqlite sensors: mode = 1
12:07:26:545 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:546 DB found sensor Bewegungsmelder 2
12:07:26:547 DB skip loading sensor Bewegungsmelder 2, handled by DDF Aqara motion sensor RTCGQ11LM
12:07:26:548 Sqlite sensors: sid = 8
12:07:26:548 Sqlite sensors: name = MultisensorDusche
12:07:26:548 Sqlite sensors: type = ZHATemperature
12:07:26:549 Sqlite sensors: modelid = lumi.weather
12:07:26:549 Sqlite sensors: manufacturername = LUMI
12:07:26:549 Sqlite sensors: uniqueid = 00:15:8d:00:07:08:49:2b-01-0402
12:07:26:549 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:550 Sqlite sensors: state = {"lastupdated":"2023-08-29T08:37:34.057","temperature":2510,"temperature_bis":null}
12:07:26:550 Sqlite sensors: config = {"battery":98,"offset":0,"on":true,"reachable":false}
12:07:26:550 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1026],"p":260}
12:07:26:551 Sqlite sensors: deletedState = normal
12:07:26:551 Sqlite sensors: mode = 1
12:07:26:551 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:552 DB found sensor MultisensorDusche 8
12:07:26:554 DB skip loading sensor MultisensorDusche 8, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:554 Sqlite sensors: sid = 7
12:07:26:555 Sqlite sensors: name = MultisensorDusche
12:07:26:555 Sqlite sensors: type = ZHAHumidity
12:07:26:555 Sqlite sensors: modelid = lumi.weather
12:07:26:556 Sqlite sensors: manufacturername = LUMI
12:07:26:556 Sqlite sensors: uniqueid = 00:15:8d:00:07:08:49:2b-01-0405
12:07:26:556 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:556 Sqlite sensors: state = {"humidity":5287,"humidity_bis":null,"lastupdated":"2023-08-29T08:37:34.133"}
12:07:26:556 Sqlite sensors: config = {"battery":98,"offset":0,"on":true,"reachable":false}
12:07:26:557 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1029],"p":260}
12:07:26:557 Sqlite sensors: deletedState = normal
12:07:26:557 Sqlite sensors: mode = 1
12:07:26:557 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:558 DB found sensor MultisensorDusche 7
12:07:26:560 DB skip loading sensor MultisensorDusche 7, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:561 Sqlite sensors: sid = 9
12:07:26:561 Sqlite sensors: name = MultisensorDusche
12:07:26:561 Sqlite sensors: type = ZHAPressure
12:07:26:562 Sqlite sensors: modelid = lumi.weather
12:07:26:562 Sqlite sensors: manufacturername = LUMI
12:07:26:562 Sqlite sensors: uniqueid = 00:15:8d:00:07:08:49:2b-01-0403
12:07:26:562 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:563 Sqlite sensors: state = {"lastupdated":"2023-08-29T08:37:34.173","pressure":946,"pressure_bis":null}
12:07:26:563 Sqlite sensors: config = {"battery":98,"offset":0,"on":true,"reachable":false}
12:07:26:563 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1027],"p":260}
12:07:26:564 Sqlite sensors: deletedState = normal
12:07:26:564 Sqlite sensors: mode = 1
12:07:26:564 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:565 DB found sensor MultisensorDusche 9
12:07:26:566 DB skip loading sensor MultisensorDusche 9, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:567 Sqlite sensors: sid = 11
12:07:26:567 Sqlite sensors: name = MultisensorBad
12:07:26:568 Sqlite sensors: type = ZHATemperature
12:07:26:568 Sqlite sensors: modelid = lumi.weather
12:07:26:568 Sqlite sensors: manufacturername = LUMI
12:07:26:568 Sqlite sensors: uniqueid = 00:15:8d:00:07:e3:dd:45-01-0402
12:07:26:569 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:569 Sqlite sensors: state = {"lastupdated":"2023-08-29T08:25:40.986","temperature":2499,"temperature_bis":null}
12:07:26:569 Sqlite sensors: config = {"battery":98,"offset":0,"on":true,"reachable":false}
12:07:26:569 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1026],"p":260}
12:07:26:570 Sqlite sensors: deletedState = normal
12:07:26:570 Sqlite sensors: mode = 1
12:07:26:570 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:571 DB found sensor MultisensorBad 11
12:07:26:573 DB skip loading sensor MultisensorBad 11, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:573 Sqlite sensors: sid = 10
12:07:26:574 Sqlite sensors: name = MultisensorBad
12:07:26:574 Sqlite sensors: type = ZHAHumidity
12:07:26:574 Sqlite sensors: modelid = lumi.weather
12:07:26:574 Sqlite sensors: manufacturername = LUMI
12:07:26:575 Sqlite sensors: uniqueid = 00:15:8d:00:07:e3:dd:45-01-0405
12:07:26:575 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:575 Sqlite sensors: state = {"humidity":5042,"humidity_bis":null,"lastupdated":"2023-08-29T08:25:40.990"}
12:07:26:575 Sqlite sensors: config = {"battery":98,"offset":0,"on":true,"reachable":false}
12:07:26:575 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1029],"p":260}
12:07:26:576 Sqlite sensors: deletedState = normal
12:07:26:576 Sqlite sensors: mode = 1
12:07:26:576 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:577 DB found sensor MultisensorBad 10
12:07:26:579 DB skip loading sensor MultisensorBad 10, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:579 Sqlite sensors: sid = 12
12:07:26:580 Sqlite sensors: name = MultisensorBad
12:07:26:580 Sqlite sensors: type = ZHAPressure
12:07:26:580 Sqlite sensors: modelid = lumi.weather
12:07:26:581 Sqlite sensors: manufacturername = LUMI
12:07:26:581 Sqlite sensors: uniqueid = 00:15:8d:00:07:e3:dd:45-01-0403
12:07:26:581 Sqlite sensors: swversion = 0.0.0_0005
12:07:26:582 Sqlite sensors: state = {"lastupdated":"2023-08-29T08:25:41.063","pressure":946,"pressure_bis":null}
12:07:26:582 Sqlite sensors: config = {"battery":98,"offset":0,"on":true,"reachable":false}
12:07:26:582 Sqlite sensors: fingerprint = {"d":24321,"ep":1,"in":[0,1027],"p":260}
12:07:26:582 Sqlite sensors: deletedState = normal
12:07:26:582 Sqlite sensors: mode = 1
12:07:26:583 Sqlite sensors: lastseen = 2023-08-29T09:01Z
12:07:26:584 DB found sensor MultisensorBad 12
12:07:26:585 DB skip loading sensor MultisensorBad 12, handled by DDF Aqara Temperature and Humidity Sensor WSDCGQ11LM
12:07:26:586 Sqlite sensors: sid = 3
12:07:26:586 Sqlite sensors: name = Presence 3
12:07:26:586 Sqlite sensors: type = ZHAPresence
12:07:26:587 Sqlite sensors: modelid = lumi.sensor_motion.aq2
12:07:26:587 Sqlite sensors: manufacturername = LUMI
12:07:26:587 Sqlite sensors: uniqueid = 00:15:8d:00:07:e2:f0:73-01-0406
12:07:26:587 Sqlite sensors: swversion = 3000-0001
12:07:26:588 Sqlite sensors: state = {"lastupdated":"2023-08-29T09:25:11.792","presence":false}
12:07:26:588 Sqlite sensors: config = {"battery":100,"duration":60,"on":true,"reachable":true,"temperature":2300}
12:07:26:588 Sqlite sensors: fingerprint = {"d":263,"ep":1,"in":[1030],"p":260}
12:07:26:589 Sqlite sensors: deletedState = normal
12:07:26:589 Sqlite sensors: mode = 1
12:07:26:589 Sqlite sensors: lastseen = 2023-08-29T09:24Z
12:07:26:590 DB found sensor Presence 3 3
12:07:26:591 DB skip loading sensor Presence 3 3, handled by DDF Aqara motion sensor RTCGQ11LM
12:07:26:592 sql exec SELECT * FROM gateways
12:07:27:391 [INFO] - Setting environment variable 'TZ=:/etc/localtime'...
12:07:27:393 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:07:27:396 Started websocket server on 0.0.0.0, port: 443
12:07:27:398 <?xml version="1.0" encoding="UTF-8" ?>
12:07:27:398 <root xmlns="urn:schemas-upnp-org:device-1-0">
12:07:27:398   <specVersion>
12:07:27:398     <major>1</major>
12:07:27:399     <minor>0</minor>
12:07:27:399   </specVersion>
12:07:27:399   <URLBase>http://10.15.5.9:80/</URLBase>
12:07:27:399   <device>
12:07:27:399     <deviceType>urn:schemas-upnp-org:device:Basic:1</deviceType>
12:07:27:399     <friendlyName>DeconzSchlafz (10.15.5.9)</friendlyName>
12:07:27:399     <manufacturer>Royal Philips Electronics</manufacturer>
12:07:27:400     <manufacturerURL>http://www.dresden-elektronik.de</manufacturerURL>
12:07:27:400     <modelDescription>Philips hue compatible Personal Wireless Lighting</modelDescription>
12:07:27:400     <modelName>Philips hue bridge 2015</modelName>
12:07:27:400     <modelNumber>BSB002</modelNumber>
12:07:27:400     <modelURL>http://www.dresden-elektronik.de</modelURL>
12:07:27:400     <serialNumber>00212E0A5215</serialNumber>
12:07:27:400     <UDN>uuid:01a3f748-0fcb-47d7-9b7f-595ae0cdde07</UDN>
12:07:27:400     <presentationURL>index.html</presentationURL>
12:07:27:401     <iconList>
12:07:27:401       <icon>
12:07:27:401         <mimetype>image/png</mimetype>
12:07:27:401         <height>48</height>
12:07:27:401         <width>48</width>
12:07:27:401         <depth>24</depth>
12:07:27:401         <url>hue_logo_0.png</url>
12:07:27:402       </icon>
12:07:27:402     </iconList>
12:07:27:402   </device>
12:07:27:402 </root>
12:07:27:403 <?xml version="1.0" encoding="UTF-8" ?>
12:07:27:403 <root xmlns="urn:schemas-upnp-org:device-1-0">
12:07:27:403   <specVersion>
12:07:27:403     <major>1</major>
12:07:27:403     <minor>0</minor>
12:07:27:403   </specVersion>
12:07:27:404   <URLBase>http://10.15.5.9:80/</URLBase>
12:07:27:404   <device>
12:07:27:404     <deviceType>urn:schemas-upnp-org:device:Basic:1</deviceType>
12:07:27:404     <friendlyName>DeconzSchlafz (10.15.5.9)</friendlyName>
12:07:27:404     <manufacturer>Royal Philips Electronics</manufacturer>
12:07:27:404     <manufacturerURL>http://www.dresden-elektronik.de</manufacturerURL>
12:07:27:404     <modelDescription>Philips hue compatible Personal Wireless Lighting</modelDescription>
12:07:27:404     <modelName>Philips hue bridge 2015</modelName>
12:07:27:405     <modelNumber>BSB002</modelNumber>
12:07:27:405     <modelURL>http://www.dresden-elektronik.de</modelURL>
12:07:27:405     <serialNumber>00212E0A5215</serialNumber>
12:07:27:405     <UDN>uuid:01a3f748-0fcb-47d7-9b7f-595ae0cdde07</UDN>
12:07:27:405     <presentationURL>index.html</presentationURL>
12:07:27:405     <iconList>
12:07:27:405       <icon>
12:07:27:405         <mimetype>image/png</mimetype>
12:07:27:406         <height>48</height>
12:07:27:406         <width>48</width>
12:07:27:406         <depth>24</depth>
12:07:27:406         <url>hue_logo_0.png</url>
12:07:27:406       </icon>
12:07:27:407     </iconList>
12:07:27:407   </device>
12:07:27:407 </root>
12:07:27:412 [INFO] - Found file containing button maps. Parsing data...
12:07:27:549 [INFO] - Button maps loaded.
12:07:27:561 found node plugin: libde_rest_plugin.so - REST API Plugin
12:07:27:567 found node plugin: libde_signal_plugin.so - Signal Monitor Plugin
12:07:27:573 OTAU: image path does not exist: /home/pi/otau
12:07:27:666 found node plugin: libstd_otau_plugin.so - STD OTAU Plugin
12:07:27:676 Node: id: 1, 00:21:2e:ff:ff:0a:52:15 (0x00212EFFFF0A5215) scene: 0.000000, 0.000000
12:07:27:679 Node: id: 6, 00:15:8d:00:09:50:d8:2a (0x00158D000950D82A) scene: -46.000000, -30.000000
12:07:27:683 Node: id: 3, 00:15:8d:00:07:e4:88:f3 (0x00158D0007E488F3) scene: -170.000000, -102.000000
12:07:27:687 Node: id: 2, 00:15:8d:00:07:e2:f0:73 (0x00158D0007E2F073) scene: -90.000000, -76.000000
12:07:27:691 Node: id: 4, 00:15:8d:00:07:08:49:2b (0x00158D000708492B) scene: -98.000000, 111.000000
12:07:27:697 Node: id: 5, 00:15:8d:00:07:e3:dd:45 (0x00158D0007E3DD45) scene: 193.000000, -70.000000
12:07:27:853 sql exec SELECT * FROM nodes WHERE mac='00:21:2e:ff:ff:0a:52:15-01' COLLATE NOCASE AND state != 'deleted'
12:07:27:854 sql exec SELECT * FROM nodes WHERE mac='0x00212effff0a5215' COLLATE NOCASE AND state != 'deleted'
12:07:27:856 DB pushZdpDescriptorDb()
12:07:27:856 DB save zll database items 0x00000880
12:07:27:859 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('1', 'Daylight', 'Daylight', 'PHDL00', 'Philips', '00:21:2e:ff:ff:0a:52:15-01', '1.0', '{"dark":false,"daylight":true,"lastupdated":"2023-08-29T11:07:27.393","status":160,"sunrise":"2023-08-29T04:41:25","sunset":"2023-08-29T18:15:22"}', '{"configured":true,"lat":"47.3664","long":"8.5546","on":true,"sunriseoffset":30,"sunsetoffset":-30}', '', 'normal', '1', '', '')
12:07:27:861 DB sql exec UPDATE devices SET nwk = 0 WHERE mac = '00:21:2e:ff:ff:0a:52:15';INSERT INTO devices (mac,nwk,timestamp) SELECT '00:21:2e:ff:ff:0a:52:15', 0, strftime('%s','now') WHERE (SELECT changes() = 0);
12:07:27:893 DB saved in 36 ms
12:07:27:895 sql exec SELECT * FROM nodes WHERE mac='00:21:2e:ff:ff:0a:52:15-01' COLLATE NOCASE AND state != 'deleted'
12:07:27:896 sql exec SELECT * FROM nodes WHERE mac='0x00212effff0a5215' COLLATE NOCASE AND state != 'deleted'
12:07:27:898 DB pushZdpDescriptorDb()
12:07:27:900 sql exec SELECT * FROM nodes WHERE mac='00:21:2e:ff:ff:0a:52:15-01' COLLATE NOCASE AND state != 'deleted'
12:07:27:901 sql exec SELECT * FROM nodes WHERE mac='0x00212effff0a5215' COLLATE NOCASE AND state != 'deleted'
12:07:27:903 DB pushZdpDescriptorDb()
12:07:27:908 DB pushZdpDescriptorDb()
12:07:27:908 DB save zll database items 0x00000800
12:07:27:908 DB sql exec UPDATE devices SET nwk = 7192 WHERE mac = '00:15:8d:00:09:50:d8:2a';INSERT INTO devices (mac,nwk,timestamp) SELECT '00:15:8d:00:09:50:d8:2a', 7192, strftime('%s','now') WHERE (SELECT changes() = 0);
12:07:27:910 DB saved in 1 ms
12:07:27:912 DB pushZdpDescriptorDb()
12:07:27:916 DB pushZdpDescriptorDb()
12:07:27:917 DB save zll database items 0x00000800
12:07:27:917 DB sql exec UPDATE devices SET nwk = 47363 WHERE mac = '00:15:8d:00:07:e4:88:f3';INSERT INTO devices (mac,nwk,timestamp) SELECT '00:15:8d:00:07:e4:88:f3', 47363, strftime('%s','now') WHERE (SELECT changes() = 0);
12:07:27:919 DB saved in 1 ms
12:07:27:920 DB pushZdpDescriptorDb()
12:07:27:925 DB pushZdpDescriptorDb()
12:07:27:925 DB save zll database items 0x00000800
12:07:27:925 DB sql exec UPDATE devices SET nwk = 48783 WHERE mac = '00:15:8d:00:07:e2:f0:73';INSERT INTO devices (mac,nwk,timestamp) SELECT '00:15:8d:00:07:e2:f0:73', 48783, strftime('%s','now') WHERE (SELECT changes() = 0);
12:07:27:927 DB saved in 1 ms
12:07:27:929 DB pushZdpDescriptorDb()
12:07:27:945 DB pushZdpDescriptorDb()
12:07:27:945 DB save zll database items 0x00000800
12:07:27:945 DB sql exec UPDATE devices SET nwk = 58983 WHERE mac = '00:15:8d:00:07:08:49:2b';INSERT INTO devices (mac,nwk,timestamp) SELECT '00:15:8d:00:07:08:49:2b', 58983, strftime('%s','now') WHERE (SELECT changes() = 0);
12:07:27:947 DB saved in 1 ms
12:07:27:949 DB pushZdpDescriptorDb()
12:07:27:954 DB pushZdpDescriptorDb()
12:07:27:954 DB save zll database items 0x00000800
12:07:27:954 DB sql exec UPDATE devices SET nwk = 61061 WHERE mac = '00:15:8d:00:07:e3:dd:45';INSERT INTO devices (mac,nwk,timestamp) SELECT '00:15:8d:00:07:e3:dd:45', 61061, strftime('%s','now') WHERE (SELECT changes() = 0);
12:07:27:956 DB saved in 1 ms
12:07:27:957 DB pushZdpDescriptorDb()
12:07:28:330 dlg action: Read binding table
12:07:28:453 SQL exec failed: SELECT attr FROM sensors WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0402' AND deletedState = 'normal', error: no such column: attr (1)
12:07:28:461 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0402' AND deletedState = 'normal', error: query aborted (4)
12:07:28:492 SQL exec failed: SELECT attr FROM sensors WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0405' AND deletedState = 'normal', error: no such column: attr (1)
12:07:28:495 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0405' AND deletedState = 'normal', error: query aborted (4)
12:07:28:500 SQL exec failed: INSERT INTO sub_devices (device_id,uniqueid,timestamp) SELECT id, '00:15:8d:00:09:50:d8:2a-01-0403', 1693307248 FROM devices WHERE mac = '00:15:8d:00:09:50:d8:2a', error: database is locked (5)
12:07:28:516 SQL exec failed: SELECT attr FROM sensors WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0403' AND deletedState = 'normal', error: no such column: attr (1)
12:07:28:519 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0403' AND deletedState = 'normal', error: query aborted (4)
12:07:28:520 DEV found DDF for 0x00158D000950D82A, path: /usr/share/deCONZ/devices/xiaomi/lumi_weather.json
12:07:28:576 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0402' AND deletedState = 'normal', error: query aborted (4)
12:07:28:609 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0405' AND deletedState = 'normal', error: query aborted (4)
12:07:28:674 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0403' AND deletedState = 'normal', error: query aborted (4)
12:07:28:674 DEV found DDF for 0x00158D0007E488F3, path: /usr/share/deCONZ/devices/xiaomi/lumi_weather.json
12:07:28:674 UPNP socket not bound, state: 0
12:07:28:810 DEV found DDF for 0x00158D0007E2F073, path: /usr/share/deCONZ/devices/xiaomi/xiaomi_rtcgqq11lm_presence_sensor.json
12:07:28:877 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0402' AND deletedState = 'normal', error: query aborted (4)
12:07:28:910 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0405' AND deletedState = 'normal', error: query aborted (4)
12:07:28:965 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0403' AND deletedState = 'normal', error: query aborted (4)
12:07:28:965 DEV found DDF for 0x00158D000708492B, path: /usr/share/deCONZ/devices/xiaomi/lumi_weather.json
12:07:28:011 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0402' AND deletedState = 'normal', error: query aborted (4)
12:07:29:057 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0405' AND deletedState = 'normal', error: query aborted (4)
12:07:29:101 SQL exec failed: SELECT state FROM sensors WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0403' AND deletedState = 'normal', error: query aborted (4)
12:07:29:101 DEV found DDF for 0x00158D0007E3DD45, path: /usr/share/deCONZ/devices/xiaomi/lumi_weather.json
12:07:29:588 COM: /dev/ttyAMA0 :  (0x0000/0x0000)
12:07:29:589 COM: /dev/ttyS0 :  (0x0000/0x0000)
12:07:29:589 dev /dev/ttyS0 (/dev/ttyS0)
12:07:29:602 auto connect com /dev/ttyS0
12:07:29:643 Skip idle timer callback, too early: elapsed 832 msec
12:07:31:152 [Master] read param with arg 0x18
12:07:31:152 [Master] read param with arg 0x13
12:07:31:153 [Master] read param with arg 0x13
12:07:31:153 [Master] read param with arg 0x13
12:07:31:378 Device firmware version 0x26690700 RaspBee
12:07:31:430 unlocked max nodes: 512
12:07:31:492 Device protocol version: 0x010E
12:07:31:607 APS-DATA.request id: 4, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:31:607 	asdu (length: 2): 0000
12:07:31:722 [Master] read param with arg 0x19
12:07:31:872 Current channel 11
12:07:31:962 CTRL got nwk update id 1
12:07:31:992 CTRL ANT_CTRL 0x03
12:07:32:042 CTRL read param resp id: 0x28, status: 0x04
12:07:32:202 CTRL read param resp id: 0x13, status: 0x04
12:07:32:244 GW update firmware found: /usr/share/deCONZ/firmware/deCONZ_ConBeeII_0x26720700.bin.GCF
12:07:32:244 GW firmware version: 0x26690700
12:07:32:473 APS-DATA.confirm id: 4, status: 0x00 SUCCESS
12:07:32:473 APS-DATA.confirm request id: 4 -> confirmed, timeout 7740515
12:07:32:506 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:32:506 	asdu: 000005000115520affff2e210073f0e207008d15008fbe120001fc
12:07:32:506 APS-DATA.indication request id: 4 -> finished
12:07:32:507 APS-DATA.request id: 4 erase from queue
12:07:32:507 APS-DATA.request id: 7, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:32:507 	asdu (length: 2): 0201
12:07:32:572 APS-DATA.confirm id: 7, status: 0x00 SUCCESS
12:07:32:572 APS-DATA.confirm request id: 7 -> confirmed, timeout 7741415
12:07:32:606 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:32:606 	asdu: 020005010115520affff2e21002b490807008d150067e6120001f4
12:07:32:606 APS-DATA.indication request id: 7 -> finished
12:07:32:606 APS-DATA.request id: 7 erase from queue
12:07:32:607 APS-DATA.request id: 9, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:32:607 	asdu (length: 2): 0302
12:07:32:692 APS-DATA.confirm id: 9, status: 0x00 SUCCESS
12:07:32:692 APS-DATA.confirm request id: 9 -> confirmed, timeout 7741515
12:07:32:722 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:32:722 	asdu: 030005020115520affff2e21002ad85009008d1500181c120001ff
12:07:32:722 APS-DATA.indication request id: 9 -> finished
12:07:32:722 APS-DATA.request id: 9 erase from queue
12:07:32:723 APS-DATA.request id: 11, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:32:723 	asdu (length: 2): 0403
12:07:32:782 APS-DATA.confirm id: 11, status: 0x00 SUCCESS
12:07:32:782 APS-DATA.confirm request id: 11 -> confirmed, timeout 7741631
12:07:32:812 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:32:812 	asdu: 040005030115520affff2e2100f388e407008d150003b9120001eb
12:07:32:812 APS-DATA.indication request id: 11 -> finished
12:07:32:812 APS-DATA.request id: 11 erase from queue
12:07:32:813 APS-DATA.request id: 13, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:32:813 	asdu (length: 2): 0504
12:07:32:872 APS-DATA.confirm id: 13, status: 0x00 SUCCESS
12:07:32:872 APS-DATA.confirm request id: 13 -> confirmed, timeout 7741721
12:07:32:902 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:32:902 	asdu: 050005040115520affff2e210045dde307008d150085ee120001f9
12:07:32:902 APS-DATA.indication request id: 13 -> finished
12:07:32:902 APS-DATA.request id: 13 erase from queue
12:07:32:943 Incr. ZDP retry count 2 on item 7
12:07:32:944 APS-DATA.request id: 16, addrmode: 0x02, addr: 0x0000, profile: 0x0000, cluster: 0x0005, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
12:07:32:944 	asdu (length: 3): 070000
12:07:32:944 Delay APS request id: 16 delayed, 20 ms till send
12:07:32:992 Delay APS request id: 16 delayed, 20 ms till send
12:07:33:043 Delay APS request id: 16 delayed, 20 ms till send
12:07:33:092 Delay APS request id: 16 delayed, 20 ms till send
12:07:33:142 Delay APS request id: 16 delayed, 20 ms till send
12:07:33:252 APS-DATA.confirm id: 16, status: 0x00 SUCCESS
12:07:33:252 APS-DATA.confirm request id: 16 -> confirmed, timeout 7742094
12:07:33:286 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8005, lqi: 221, rssi: 30
12:07:33:286 	asdu: 070000000201f2
12:07:33:286 APS-DATA.indication request id: 16 -> finished
12:07:33:286 APS-DATA.request id: 16 erase from queue
12:07:34:322 APS-DATA.request id: 18, addrmode: 0x02, addr: 0x0000, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 0 len: 4 tx.options 0x00
12:07:34:322 	asdu (length: 4): 080000f2
12:07:34:322 Delay APS request id: 18 delayed, 20 ms till send
12:07:34:375 Delay APS request id: 18 delayed, 20 ms till send
12:07:34:428 Delay APS request id: 18 delayed, 20 ms till send
12:07:34:481 Delay APS request id: 18 delayed, 20 ms till send
12:07:34:533 Delay APS request id: 18 delayed, 20 ms till send
12:07:34:585 Delay APS request id: 18 delayed, 20 ms till send
12:07:34:702 APS-DATA.confirm id: 18, status: 0x00 SUCCESS
12:07:34:702 APS-DATA.confirm request id: 18 -> confirmed, timeout 7743532
12:07:34:742 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 221, rssi: 30
12:07:34:742 	asdu: 080000000af2e0a164000100012100
12:07:34:742 APS-DATA.indication request id: 18 -> finished
12:07:34:742 APS-DATA.request id: 18 erase from queue
12:07:34:743 sql exec SELECT * FROM nodes WHERE mac='00:21:2e:ff:ff:0a:52:15-01' COLLATE NOCASE AND state != 'deleted'
12:07:34:745 sql exec SELECT * FROM nodes WHERE mac='0x00212effff0a5215' COLLATE NOCASE AND state != 'deleted'
12:07:34:747 DB pushZdpDescriptorDb()
12:07:34:785 APS-DATA.request id: 20, addrmode: 0x02, addr: 0x0000, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 0 len: 4 tx.options 0x00
12:07:34:785 	asdu (length: 4): 09000001
12:07:34:785 Delay APS request id: 20 delayed, 20 ms till send
12:07:34:838 Delay APS request id: 20 delayed, 20 ms till send
12:07:34:890 Delay APS request id: 20 delayed, 20 ms till send
12:07:34:942 Delay APS request id: 20 delayed, 20 ms till send
12:07:34:993 Delay APS request id: 20 delayed, 20 ms till send
12:07:35:042 Delay APS request id: 20 delayed, 20 ms till send
12:07:35:092 DEV Tick.Init: booted after 8000 seconds
12:07:35:093 Delay APS request id: 20 delayed, 20 ms till send
12:07:35:212 APS-DATA.confirm id: 20, status: 0x00 SUCCESS
12:07:35:212 APS-DATA.confirm request id: 20 -> confirmed, timeout 7744012
12:07:35:246 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 221, rssi: 30
12:07:35:246 	asdu: 090000001a01040105000105000006000a0019000105040100200000050205
12:07:35:246 APS-DATA.indication request id: 20 -> finished
12:07:35:246 APS-DATA.request id: 20 erase from queue
12:07:35:249 sql exec SELECT * FROM nodes WHERE mac='00:21:2e:ff:ff:0a:52:15-01' COLLATE NOCASE AND state != 'deleted'
12:07:35:250 sql exec SELECT * FROM nodes WHERE mac='0x00212effff0a5215' COLLATE NOCASE AND state != 'deleted'
12:07:35:252 DB pushZdpDescriptorDb()
12:07:37:093 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:07:37:345 APS-DATA.request id: 22, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:37:345 	asdu (length: 2): 0a00
12:07:37:412 APS-DATA.confirm id: 22, status: 0x00 SUCCESS
12:07:37:412 APS-DATA.confirm request id: 22 -> confirmed, timeout 7746253
12:07:37:452 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:37:452 	asdu: 0a0005000115520affff2e210073f0e207008d15008fbe120001fc
12:07:37:452 APS-DATA.indication request id: 22 -> finished
12:07:37:452 APS-DATA.request id: 22 erase from queue
12:07:37:453 APS-DATA.request id: 24, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:37:453 	asdu (length: 2): 0b01
12:07:37:512 APS-DATA.confirm id: 24, status: 0x00 SUCCESS
12:07:37:512 APS-DATA.confirm request id: 24 -> confirmed, timeout 7746361
12:07:37:545 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:37:545 	asdu: 0b0005010115520affff2e21002b490807008d150067e6120001f4
12:07:37:545 APS-DATA.indication request id: 24 -> finished
12:07:37:545 APS-DATA.request id: 24 erase from queue
12:07:37:546 APS-DATA.request id: 26, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:37:546 	asdu (length: 2): 0c02
12:07:37:612 APS-DATA.confirm id: 26, status: 0x00 SUCCESS
12:07:37:612 APS-DATA.confirm request id: 26 -> confirmed, timeout 7746454
12:07:37:642 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:37:642 	asdu: 0c0005020115520affff2e21002ad85009008d1500181c120001ff
12:07:37:642 APS-DATA.indication request id: 26 -> finished
12:07:37:642 APS-DATA.request id: 26 erase from queue
12:07:37:643 APS-DATA.request id: 28, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:37:643 	asdu (length: 2): 0d03
12:07:37:702 APS-DATA.confirm id: 28, status: 0x00 SUCCESS
12:07:37:702 APS-DATA.confirm request id: 28 -> confirmed, timeout 7746551
12:07:37:732 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:37:732 	asdu: 0d0005030115520affff2e2100f388e407008d150003b9120001eb
12:07:37:732 APS-DATA.indication request id: 28 -> finished
12:07:37:732 APS-DATA.request id: 28 erase from queue
12:07:37:733 APS-DATA.request id: 30, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:37:733 	asdu (length: 2): 0e04
12:07:37:792 APS-DATA.confirm id: 30, status: 0x00 SUCCESS
12:07:37:792 APS-DATA.confirm request id: 30 -> confirmed, timeout 7746641
12:07:37:822 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:37:822 	asdu: 0e0005040115520affff2e210045dde307008d150085ee120001f9
12:07:37:822 APS-DATA.indication request id: 30 -> finished
12:07:37:822 APS-DATA.request id: 30 erase from queue
12:07:42:093 GW firmware version: 0x26690700
12:07:42:624 APS-DATA.request id: 32, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:42:624 	asdu (length: 2): 0f00
12:07:42:692 APS-DATA.confirm id: 32, status: 0x00 SUCCESS
12:07:42:692 APS-DATA.confirm request id: 32 -> confirmed, timeout 7751533
12:07:42:732 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:42:732 	asdu: 0f0005000115520affff2e210073f0e207008d15008fbe120001fc
12:07:42:732 APS-DATA.indication request id: 32 -> finished
12:07:42:732 APS-DATA.request id: 32 erase from queue
12:07:42:733 APS-DATA.request id: 34, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:42:733 	asdu (length: 2): 1001
12:07:42:792 APS-DATA.confirm id: 34, status: 0x00 SUCCESS
12:07:42:792 APS-DATA.confirm request id: 34 -> confirmed, timeout 7751641
12:07:42:822 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:42:822 	asdu: 100005010115520affff2e21002b490807008d150067e6120001f4
12:07:42:823 APS-DATA.indication request id: 34 -> finished
12:07:42:823 APS-DATA.request id: 34 erase from queue
12:07:42:823 APS-DATA.request id: 36, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:42:823 	asdu (length: 2): 1102
12:07:42:882 APS-DATA.confirm id: 36, status: 0x00 SUCCESS
12:07:42:882 APS-DATA.confirm request id: 36 -> confirmed, timeout 7751731
12:07:42:912 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:42:912 	asdu: 110005020115520affff2e21002ad85009008d1500181c120001ff
12:07:42:912 APS-DATA.indication request id: 36 -> finished
12:07:42:912 APS-DATA.request id: 36 erase from queue
12:07:42:913 APS-DATA.request id: 38, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:42:913 	asdu (length: 2): 1203
12:07:42:972 APS-DATA.confirm id: 38, status: 0x00 SUCCESS
12:07:42:972 APS-DATA.confirm request id: 38 -> confirmed, timeout 7751821
12:07:43:012 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:43:012 	asdu: 120005030115520affff2e2100f388e407008d150003b9120001eb
12:07:43:012 APS-DATA.indication request id: 38 -> finished
12:07:43:012 APS-DATA.request id: 38 erase from queue
12:07:43:013 APS-DATA.request id: 40, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:43:013 	asdu (length: 2): 1304
12:07:43:072 APS-DATA.confirm id: 40, status: 0x00 SUCCESS
12:07:43:072 APS-DATA.confirm request id: 40 -> confirmed, timeout 7751921
12:07:43:102 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:43:102 	asdu: 130005040115520affff2e210045dde307008d150085ee120001f9
12:07:43:102 APS-DATA.indication request id: 40 -> finished
12:07:43:102 APS-DATA.request id: 40 erase from queue
12:07:47:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:07:47:904 APS-DATA.request id: 42, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:47:904 	asdu (length: 2): 1400
12:07:47:972 APS-DATA.confirm id: 42, status: 0x00 SUCCESS
12:07:47:972 APS-DATA.confirm request id: 42 -> confirmed, timeout 7756812
12:07:47:006 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:47:006 	asdu: 140005000115520affff2e210073f0e207008d15008fbe120001fc
12:07:47:006 APS-DATA.indication request id: 42 -> finished
12:07:47:006 APS-DATA.request id: 42 erase from queue
12:07:47:006 APS-DATA.request id: 44, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:47:007 	asdu (length: 2): 1501
12:07:48:072 APS-DATA.confirm id: 44, status: 0x00 SUCCESS
12:07:48:072 APS-DATA.confirm request id: 44 -> confirmed, timeout 7756915
12:07:48:106 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:48:106 	asdu: 150005010115520affff2e21002b490807008d150067e6120001f4
12:07:48:106 APS-DATA.indication request id: 44 -> finished
12:07:48:106 APS-DATA.request id: 44 erase from queue
12:07:48:107 APS-DATA.request id: 46, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:48:107 	asdu (length: 2): 1602
12:07:48:172 APS-DATA.confirm id: 46, status: 0x00 SUCCESS
12:07:48:172 APS-DATA.confirm request id: 46 -> confirmed, timeout 7757015
12:07:48:206 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:48:206 	asdu: 160005020115520affff2e21002ad85009008d1500181c120001ff
12:07:48:206 APS-DATA.indication request id: 46 -> finished
12:07:48:206 APS-DATA.request id: 46 erase from queue
12:07:48:207 APS-DATA.request id: 48, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:48:207 	asdu (length: 2): 1703
12:07:48:282 APS-DATA.confirm id: 48, status: 0x00 SUCCESS
12:07:48:282 APS-DATA.confirm request id: 48 -> confirmed, timeout 7757115
12:07:48:282 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:48:282 	asdu: 170005030115520affff2e2100f388e407008d150003b9120001eb
12:07:48:282 APS-DATA.indication request id: 48 -> finished
12:07:48:283 APS-DATA.request id: 48 erase from queue
12:07:48:283 APS-DATA.request id: 50, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:48:283 	asdu (length: 2): 1804
12:07:48:352 APS-DATA.confirm id: 50, status: 0x00 SUCCESS
12:07:48:352 APS-DATA.confirm request id: 50 -> confirmed, timeout 7757191
12:07:48:386 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:48:386 	asdu: 180005040115520affff2e210045dde307008d150085ee120001f9
12:07:48:386 APS-DATA.indication request id: 50 -> finished
12:07:48:386 APS-DATA.request id: 50 erase from queue
12:07:48:593 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1
12:07:48:594 Idle timer triggered
12:07:52:093 GW firmware version: 0x26690700
12:07:53:184 APS-DATA.request id: 52, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:53:184 	asdu (length: 2): 1900
12:07:53:252 APS-DATA.confirm id: 52, status: 0x00 SUCCESS
12:07:53:252 APS-DATA.confirm request id: 52 -> confirmed, timeout 7762092
12:07:53:286 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:53:286 	asdu: 190005000115520affff2e210073f0e207008d15008fbe120001fc
12:07:53:286 APS-DATA.indication request id: 52 -> finished
12:07:53:286 APS-DATA.request id: 52 erase from queue
12:07:53:286 APS-DATA.request id: 54, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:53:287 	asdu (length: 2): 1a01
12:07:53:352 APS-DATA.confirm id: 54, status: 0x00 SUCCESS
12:07:53:352 APS-DATA.confirm request id: 54 -> confirmed, timeout 7762195
12:07:53:386 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:53:386 	asdu: 1a0005010115520affff2e21002b490807008d150067e6120001f4
12:07:53:386 APS-DATA.indication request id: 54 -> finished
12:07:53:386 APS-DATA.request id: 54 erase from queue
12:07:53:387 APS-DATA.request id: 56, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:53:387 	asdu (length: 2): 1b02
12:07:53:452 APS-DATA.confirm id: 56, status: 0x00 SUCCESS
12:07:53:452 APS-DATA.confirm request id: 56 -> confirmed, timeout 7762295
12:07:53:486 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:53:486 	asdu: 1b0005020115520affff2e21002ad85009008d1500181c120001ff
12:07:53:486 APS-DATA.indication request id: 56 -> finished
12:07:53:486 APS-DATA.request id: 56 erase from queue
12:07:53:487 APS-DATA.request id: 58, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:53:487 	asdu (length: 2): 1c03
12:07:53:552 APS-DATA.confirm id: 58, status: 0x00 SUCCESS
12:07:53:552 APS-DATA.confirm request id: 58 -> confirmed, timeout 7762395
12:07:53:586 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:53:586 	asdu: 1c0005030115520affff2e2100f388e407008d150003b9120001eb
12:07:53:586 APS-DATA.indication request id: 58 -> finished
12:07:53:586 APS-DATA.request id: 58 erase from queue
12:07:53:587 APS-DATA.request id: 60, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:53:587 	asdu (length: 2): 1d04
12:07:53:652 APS-DATA.confirm id: 60, status: 0x00 SUCCESS
12:07:53:652 APS-DATA.confirm request id: 60 -> confirmed, timeout 7762495
12:07:53:700 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:53:700 	asdu: 1d0005040115520affff2e210045dde307008d150085ee120001f9
12:07:53:700 APS-DATA.indication request id: 60 -> finished
12:07:53:701 APS-DATA.request id: 60 erase from queue
12:07:53:859 New websocket 10.15.4.240:50908 (state: 3) 
12:07:57:093 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:07:58:104 APS-DATA.request id: 62, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:58:104 	asdu (length: 2): 1e00
12:07:58:172 APS-DATA.confirm id: 62, status: 0x00 SUCCESS
12:07:58:172 APS-DATA.confirm request id: 62 -> confirmed, timeout 7767013
12:07:58:206 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:58:206 	asdu: 1e0005000115520affff2e210073f0e207008d15008fbe120001fc
12:07:58:206 APS-DATA.indication request id: 62 -> finished
12:07:58:207 APS-DATA.request id: 62 erase from queue
12:07:58:207 APS-DATA.request id: 64, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:58:207 	asdu (length: 2): 1f01
12:07:58:272 APS-DATA.confirm id: 64, status: 0x00 SUCCESS
12:07:58:272 APS-DATA.confirm request id: 64 -> confirmed, timeout 7767115
12:07:58:306 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:58:306 	asdu: 1f0005010115520affff2e21002b490807008d150067e6120001f4
12:07:58:307 APS-DATA.indication request id: 64 -> finished
12:07:58:307 APS-DATA.request id: 64 erase from queue
12:07:58:307 APS-DATA.request id: 66, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:58:307 	asdu (length: 2): 2002
12:07:58:392 APS-DATA.confirm id: 66, status: 0x00 SUCCESS
12:07:58:392 APS-DATA.confirm request id: 66 -> confirmed, timeout 7767215
12:07:58:422 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:58:422 	asdu: 200005020115520affff2e21002ad85009008d1500181c120001ff
12:07:58:422 APS-DATA.indication request id: 66 -> finished
12:07:58:423 APS-DATA.request id: 66 erase from queue
12:07:58:423 APS-DATA.request id: 68, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:58:423 	asdu (length: 2): 2103
12:07:58:482 APS-DATA.confirm id: 68, status: 0x00 SUCCESS
12:07:58:482 APS-DATA.confirm request id: 68 -> confirmed, timeout 7767331
12:07:58:512 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:07:58:512 	asdu: 210005030115520affff2e2100f388e407008d150003b9120001eb
12:07:58:512 APS-DATA.indication request id: 68 -> finished
12:07:58:512 APS-DATA.request id: 68 erase from queue
12:07:58:513 APS-DATA.request id: 70, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:07:58:513 	asdu (length: 2): 2204
12:07:58:572 APS-DATA.confirm id: 70, status: 0x00 SUCCESS
12:07:58:572 APS-DATA.confirm request id: 70 -> confirmed, timeout 7767421
12:07:58:602 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 231, rssi: -65
12:07:58:602 	asdu: 220005040115520affff2e210045dde307008d150085ee120001f9
12:07:58:602 APS-DATA.indication request id: 70 -> finished
12:07:58:602 APS-DATA.request id: 70 erase from queue
12:08:02:092 GW firmware version: 0x26690700
12:08:03:384 APS-DATA.request id: 72, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:03:384 	asdu (length: 2): 2300
12:08:03:452 APS-DATA.confirm id: 72, status: 0x00 SUCCESS
12:08:03:452 APS-DATA.confirm request id: 72 -> confirmed, timeout 7772293
12:08:03:486 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:03:486 	asdu: 230005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:03:486 APS-DATA.indication request id: 72 -> finished
12:08:03:486 APS-DATA.request id: 72 erase from queue
12:08:03:487 APS-DATA.request id: 74, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:03:487 	asdu (length: 2): 2401
12:08:03:552 APS-DATA.confirm id: 74, status: 0x00 SUCCESS
12:08:03:552 APS-DATA.confirm request id: 74 -> confirmed, timeout 7772395
12:08:03:586 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:03:586 	asdu: 240005010115520affff2e21002b490807008d150067e6120001f4
12:08:03:586 APS-DATA.indication request id: 74 -> finished
12:08:03:586 APS-DATA.request id: 74 erase from queue
12:08:03:587 APS-DATA.request id: 76, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:03:587 	asdu (length: 2): 2502
12:08:03:652 APS-DATA.confirm id: 76, status: 0x00 SUCCESS
12:08:03:652 APS-DATA.confirm request id: 76 -> confirmed, timeout 7772495
12:08:03:686 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:03:686 	asdu: 250005020115520affff2e21002ad85009008d1500181c120001ff
12:08:03:686 APS-DATA.indication request id: 76 -> finished
12:08:03:686 APS-DATA.request id: 76 erase from queue
12:08:03:687 APS-DATA.request id: 78, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:03:687 	asdu (length: 2): 2603
12:08:03:752 APS-DATA.confirm id: 78, status: 0x00 SUCCESS
12:08:03:752 APS-DATA.confirm request id: 78 -> confirmed, timeout 7772595
12:08:03:786 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:03:786 	asdu: 260005030115520affff2e2100f388e407008d150003b9120001eb
12:08:03:786 APS-DATA.indication request id: 78 -> finished
12:08:03:787 APS-DATA.request id: 78 erase from queue
12:08:03:787 APS-DATA.request id: 80, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:03:787 	asdu (length: 2): 2704
12:08:03:852 APS-DATA.confirm id: 80, status: 0x00 SUCCESS
12:08:03:852 APS-DATA.confirm request id: 80 -> confirmed, timeout 7772695
12:08:03:886 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:03:886 	asdu: 270005040115520affff2e210045dde307008d150085ee120001f9
12:08:03:886 APS-DATA.indication request id: 80 -> finished
12:08:03:886 APS-DATA.request id: 80 erase from queue
12:08:07:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:08:08:664 APS-DATA.request id: 82, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:08:664 	asdu (length: 2): 2800
12:08:08:732 APS-DATA.confirm id: 82, status: 0x00 SUCCESS
12:08:08:732 APS-DATA.confirm request id: 82 -> confirmed, timeout 7777572
12:08:08:766 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:08:766 	asdu: 280005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:08:766 APS-DATA.indication request id: 82 -> finished
12:08:08:767 APS-DATA.request id: 82 erase from queue
12:08:08:767 APS-DATA.request id: 84, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:08:767 	asdu (length: 2): 2901
12:08:08:832 APS-DATA.confirm id: 84, status: 0x00 SUCCESS
12:08:08:832 APS-DATA.confirm request id: 84 -> confirmed, timeout 7777675
12:08:08:882 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:08:882 	asdu: 290005010115520affff2e21002b490807008d150067e6120001f4
12:08:08:882 APS-DATA.indication request id: 84 -> finished
12:08:08:883 APS-DATA.request id: 84 erase from queue
12:08:08:883 APS-DATA.request id: 86, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:08:883 	asdu (length: 2): 2a02
12:08:08:952 APS-DATA.confirm id: 86, status: 0x00 SUCCESS
12:08:08:952 APS-DATA.confirm request id: 86 -> confirmed, timeout 7777791
12:08:08:986 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:08:986 	asdu: 2a0005020115520affff2e21002ad85009008d1500181c120001ff
12:08:08:986 APS-DATA.indication request id: 86 -> finished
12:08:08:986 APS-DATA.request id: 86 erase from queue
12:08:08:987 APS-DATA.request id: 88, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:08:987 	asdu (length: 2): 2b03
12:08:09:052 APS-DATA.confirm id: 88, status: 0x00 SUCCESS
12:08:09:052 APS-DATA.confirm request id: 88 -> confirmed, timeout 7777895
12:08:09:086 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:09:086 	asdu: 2b0005030115520affff2e2100f388e407008d150003b9120001eb
12:08:09:086 APS-DATA.indication request id: 88 -> finished
12:08:09:087 APS-DATA.request id: 88 erase from queue
12:08:09:087 APS-DATA.request id: 90, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:09:087 	asdu (length: 2): 2c04
12:08:09:162 APS-DATA.confirm id: 90, status: 0x00 SUCCESS
12:08:09:162 APS-DATA.confirm request id: 90 -> confirmed, timeout 7777995
12:08:09:202 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:09:202 	asdu: 2c0005040115520affff2e210045dde307008d150085ee120001f9
12:08:09:202 APS-DATA.indication request id: 90 -> finished
12:08:09:202 APS-DATA.request id: 90 erase from queue
12:08:12:093 GW firmware version: 0x26690700
12:08:13:944 APS-DATA.request id: 92, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:13:944 	asdu (length: 2): 2d00
12:08:14:012 APS-DATA.confirm id: 92, status: 0x00 SUCCESS
12:08:14:012 APS-DATA.confirm request id: 92 -> confirmed, timeout 7782852
12:08:14:046 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:14:046 	asdu: 2d0005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:14:047 APS-DATA.indication request id: 92 -> finished
12:08:14:047 APS-DATA.request id: 92 erase from queue
12:08:14:047 APS-DATA.request id: 94, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:14:047 	asdu (length: 2): 2e01
12:08:14:112 APS-DATA.confirm id: 94, status: 0x00 SUCCESS
12:08:14:112 APS-DATA.confirm request id: 94 -> confirmed, timeout 7782955
12:08:14:152 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:14:152 	asdu: 2e0005010115520affff2e21002b490807008d150067e6120001f4
12:08:14:152 APS-DATA.indication request id: 94 -> finished
12:08:14:152 APS-DATA.request id: 94 erase from queue
12:08:14:153 APS-DATA.request id: 96, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:14:153 	asdu (length: 2): 2f02
12:08:14:212 APS-DATA.confirm id: 96, status: 0x00 SUCCESS
12:08:14:212 APS-DATA.confirm request id: 96 -> confirmed, timeout 7783061
12:08:14:242 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:14:242 	asdu: 2f0005020115520affff2e21002ad85009008d1500181c120001ff
12:08:14:242 APS-DATA.indication request id: 96 -> finished
12:08:14:243 APS-DATA.request id: 96 erase from queue
12:08:14:243 APS-DATA.request id: 98, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:14:243 	asdu (length: 2): 3003
12:08:14:305 APS-DATA.confirm id: 98, status: 0x00 SUCCESS
12:08:14:305 APS-DATA.confirm request id: 98 -> confirmed, timeout 7783151
12:08:14:332 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:14:332 	asdu: 300005030115520affff2e2100f388e407008d150003b9120001eb
12:08:14:332 APS-DATA.indication request id: 98 -> finished
12:08:14:332 APS-DATA.request id: 98 erase from queue
12:08:14:333 APS-DATA.request id: 100, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:14:333 	asdu (length: 2): 3104
12:08:14:402 APS-DATA.confirm id: 100, status: 0x00 SUCCESS
12:08:14:402 APS-DATA.confirm request id: 100 -> confirmed, timeout 7783241
12:08:14:432 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:14:432 	asdu: 310005040115520affff2e210045dde307008d150085ee120001f9
12:08:14:432 APS-DATA.indication request id: 100 -> finished
12:08:14:432 APS-DATA.request id: 100 erase from queue
12:08:17:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:08:18:593 Idle timer triggered
12:08:19:224 APS-DATA.request id: 102, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:19:224 	asdu (length: 2): 3200
12:08:19:292 APS-DATA.confirm id: 102, status: 0x00 SUCCESS
12:08:19:292 APS-DATA.confirm request id: 102 -> confirmed, timeout 7788132
12:08:19:332 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:19:332 	asdu: 320005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:19:332 APS-DATA.indication request id: 102 -> finished
12:08:19:332 APS-DATA.request id: 102 erase from queue
12:08:19:333 APS-DATA.request id: 104, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:19:333 	asdu (length: 2): 3301
12:08:19:392 APS-DATA.confirm id: 104, status: 0x00 SUCCESS
12:08:19:392 APS-DATA.confirm request id: 104 -> confirmed, timeout 7788241
12:08:19:432 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:19:432 	asdu: 330005010115520affff2e21002b490807008d150067e6120001f4
12:08:19:433 APS-DATA.indication request id: 104 -> finished
12:08:19:433 APS-DATA.request id: 104 erase from queue
12:08:19:433 APS-DATA.request id: 106, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:19:433 	asdu (length: 2): 3402
12:08:19:492 APS-DATA.confirm id: 106, status: 0x00 SUCCESS
12:08:19:492 APS-DATA.confirm request id: 106 -> confirmed, timeout 7788341
12:08:19:522 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:19:522 	asdu: 340005020115520affff2e21002ad85009008d1500181c120001ff
12:08:19:522 APS-DATA.indication request id: 106 -> finished
12:08:19:522 APS-DATA.request id: 106 erase from queue
12:08:19:523 APS-DATA.request id: 108, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:19:523 	asdu (length: 2): 3503
12:08:19:582 APS-DATA.confirm id: 108, status: 0x00 SUCCESS
12:08:19:582 APS-DATA.confirm request id: 108 -> confirmed, timeout 7788431
12:08:19:612 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:19:612 	asdu: 350005030115520affff2e2100f388e407008d150003b9120001eb
12:08:19:612 APS-DATA.indication request id: 108 -> finished
12:08:19:612 APS-DATA.request id: 108 erase from queue
12:08:19:613 APS-DATA.request id: 110, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:19:613 	asdu (length: 2): 3604
12:08:19:672 APS-DATA.confirm id: 110, status: 0x00 SUCCESS
12:08:19:672 APS-DATA.confirm request id: 110 -> confirmed, timeout 7788521
12:08:19:702 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:19:702 	asdu: 360005040115520affff2e210045dde307008d150085ee120001f9
12:08:19:702 APS-DATA.indication request id: 110 -> finished
12:08:19:702 APS-DATA.request id: 110 erase from queue
12:08:20:152 [Master] read param with arg 0x19
12:08:22:092 GW firmware version: 0x26690700
12:08:24:505 APS-DATA.request id: 112, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:24:505 	asdu (length: 2): 3700
12:08:24:572 APS-DATA.confirm id: 112, status: 0x00 SUCCESS
12:08:24:572 APS-DATA.confirm request id: 112 -> confirmed, timeout 7793413
12:08:24:612 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:24:612 	asdu: 370005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:24:612 APS-DATA.indication request id: 112 -> finished
12:08:24:612 APS-DATA.request id: 112 erase from queue
12:08:24:612 APS-DATA.request id: 114, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:24:612 	asdu (length: 2): 3801
12:08:24:672 APS-DATA.confirm id: 114, status: 0x00 SUCCESS
12:08:24:672 APS-DATA.confirm request id: 114 -> confirmed, timeout 7793521
12:08:24:712 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:24:712 	asdu: 380005010115520affff2e21002b490807008d150067e6120001f4
12:08:24:712 APS-DATA.indication request id: 114 -> finished
12:08:24:712 APS-DATA.request id: 114 erase from queue
12:08:24:713 APS-DATA.request id: 116, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:24:713 	asdu (length: 2): 3902
12:08:24:772 APS-DATA.confirm id: 116, status: 0x00 SUCCESS
12:08:24:772 APS-DATA.confirm request id: 116 -> confirmed, timeout 7793621
12:08:24:802 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:24:802 	asdu: 390005020115520affff2e21002ad85009008d1500181c120001ff
12:08:24:802 APS-DATA.indication request id: 116 -> finished
12:08:24:802 APS-DATA.request id: 116 erase from queue
12:08:24:802 APS-DATA.request id: 118, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:24:803 	asdu (length: 2): 3a03
12:08:24:862 APS-DATA.confirm id: 118, status: 0x00 SUCCESS
12:08:24:862 APS-DATA.confirm request id: 118 -> confirmed, timeout 7793711
12:08:24:892 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:24:892 	asdu: 3a0005030115520affff2e2100f388e407008d150003b9120001eb
12:08:24:892 APS-DATA.indication request id: 118 -> finished
12:08:24:892 APS-DATA.request id: 118 erase from queue
12:08:24:892 APS-DATA.request id: 120, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:24:893 	asdu (length: 2): 3b04
12:08:24:952 APS-DATA.confirm id: 120, status: 0x00 SUCCESS
12:08:24:952 APS-DATA.confirm request id: 120 -> confirmed, timeout 7793801
12:08:24:982 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:24:982 	asdu: 3b0005040115520affff2e210045dde307008d150085ee120001f9
12:08:24:982 APS-DATA.indication request id: 120 -> finished
12:08:24:982 APS-DATA.request id: 120 erase from queue
12:08:27:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:08:28:092 DB save zll database items 0x00000084
12:08:28:093 DB sql exec REPLACE INTO auth (apikey, devicetype, createdate, lastusedate, useragent) VALUES ('F0F76109CB', 'openHAB', '2022-10-15T13:59:22', '2023-08-29T11:07:53', 'Jetty/9.4.46.v20220331')
12:08:28:109 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693306200 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0402'
12:08:28:113 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1691260571 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0402'
12:08:28:116 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307248 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0402'
12:08:28:120 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '95', 'dev', 1693266267 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0402'
12:08:28:123 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1692428104 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0402'
12:08:28:128 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('13', 'MultisensorSchlafzimmer', 'ZHATemperature', 'lumi.weather', 'LUMI', '00:15:8d:00:09:50:d8:2a-01-0402', '0.0.0_0005', '{"lastupdated":"2023-08-29T10:50:00.346","temperature":2469,"temperature_bis":null}', '{"battery":95,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1026],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:143 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693306200 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0405'
12:08:28:146 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1691260571 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0405'
12:08:28:148 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307248 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0405'
12:08:28:153 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '95', 'dev', 1693266267 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0405'
12:08:28:156 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1692428104 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0405'
12:08:28:160 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('14', 'MultisensorSchlafzimmer', 'ZHAHumidity', 'lumi.weather', 'LUMI', '00:15:8d:00:09:50:d8:2a-01-0405', '0.0.0_0005', '{"humidity":5139,"humidity_bis":null,"lastupdated":"2023-08-29T10:50:00.372"}', '{"battery":95,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1029],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:174 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693306200 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0403'
12:08:28:177 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1691260571 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0403'
12:08:28:180 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307249 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0403'
12:08:28:184 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '95', 'dev', 1693266267 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0403'
12:08:28:187 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1692428104 FROM sub_devices WHERE uniqueid = '00:15:8d:00:09:50:d8:2a-01-0403'
12:08:28:192 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('15', 'MultisensorSchlafzimmer', 'ZHAPressure', 'lumi.weather', 'LUMI', '00:15:8d:00:09:50:d8:2a-01-0403', '0.0.0_0005', '{"lastupdated":"2023-08-29T10:50:00.414","pressure":945,"pressure_bis":null}', '{"battery":95,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1027],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:206 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1681690000 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0402'
12:08:28:209 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693306257 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0402'
12:08:28:211 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1666886001 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0402'
12:08:28:214 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307248 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0402'
12:08:28:218 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '92', 'dev', 1693280022 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0402'
12:08:28:221 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1669713120 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0402'
12:08:28:225 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('5', 'MultisensorTerrasseNord', 'ZHATemperature', 'lumi.weather', 'LUMI', '00:15:8d:00:07:e4:88:f3-01-0402', '0.0.0_0005', '{"lastupdated":"2023-08-29T10:50:57.537","temperature":1736,"temperature_bis":null}', '{"battery":92,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1026],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:237 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1681689997 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0405'
12:08:28:240 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693306257 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0405'
12:08:28:242 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1666886001 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0405'
12:08:28:245 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307248 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0405'
12:08:28:249 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '92', 'dev', 1693280022 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0405'
12:08:28:251 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1669713120 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0405'
12:08:28:255 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('4', 'MultisensorTerrasseNord', 'ZHAHumidity', 'lumi.weather', 'LUMI', '00:15:8d:00:07:e4:88:f3-01-0405', '0.0.0_0005', '{"humidity":6634,"humidity_bis":null,"lastupdated":"2023-08-29T10:50:57.544"}', '{"battery":92,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1029],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:267 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1681690002 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0403'
12:08:28:270 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693306257 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0403'
12:08:28:283 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1666886001 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0403'
12:08:28:286 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307249 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0403'
12:08:28:290 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '92', 'dev', 1693280022 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0403'
12:08:28:303 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1669713120 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e4:88:f3-01-0403'
12:08:28:307 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('6', 'MultisensorTerrasseNord', 'ZHAPressure', 'lumi.weather', 'LUMI', '00:15:8d:00:07:e4:88:f3-01-0403', '0.0.0_0005', '{"lastupdated":"2023-08-29T10:50:57.563","pressure":948,"pressure_bis":null}', '{"battery":92,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1027],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:329 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1666884829 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0406'
12:08:28:342 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693304210 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0406'
12:08:28:344 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1665760612 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0406'
12:08:28:347 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307248 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0406'
12:08:28:351 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '100', 'dev', 1665838694 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0406'
12:08:28:363 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/duration', '60', 'dev', 1665760612 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0406'
12:08:28:366 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/temperature', '2400', 'dev', 1693304210 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0406'
12:08:28:368 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'state/presence', 'false', 'dev', 1693307248 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0406'
12:08:28:371 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('3', 'Presence 3', 'ZHAPresence', 'lumi.sensor_motion.aq2', 'LUMI', '00:15:8d:00:07:e2:f0:73-01-0406', '3000-0001', '{"lastupdated":"2023-08-29T09:20:58.419","presence":false}', '{"battery":100,"duration":60,"on":true,"reachable":false,"temperature":2400}', '{"d":263,"ep":1,"in":[1030],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:404 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1666884829 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0400'
12:08:28:407 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693304210 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0400'
12:08:28:409 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1665760607 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0400'
12:08:28:422 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307249 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0400'
12:08:28:426 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '100', 'dev', 1665760607 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0400'
12:08:28:429 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/tholddark', '12000', 'dev', 1665760607 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0400'
12:08:28:441 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/tholdoffset', '7000', 'dev', 1665760607 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e2:f0:73-01-0400'
12:08:28:450 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('2', 'Bewegungsmelder', 'ZHALightLevel', 'lumi.sensor_motion.aq2', 'LUMI', '00:15:8d:00:07:e2:f0:73-01-0400', '3000-0001', '{"dark":false,"daylight":true,"lastupdated":"2023-08-29T09:24:11.516","lightlevel":23580,"lux":228}', '{"battery":100,"on":true,"reachable":false,"tholddark":12000,"tholdoffset":7000}', '{"d":263,"ep":1,"in":[1024],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:483 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1683446122 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0402'
12:08:28:486 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693305279 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0402'
12:08:28:488 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1672902704 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0402'
12:08:28:491 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307248 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0402'
12:08:28:505 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '98', 'dev', 1693166143 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0402'
12:08:28:507 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1682958048 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0402'
12:08:28:511 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('8', 'MultisensorDusche', 'ZHATemperature', 'lumi.weather', 'LUMI', '00:15:8d:00:07:08:49:2b-01-0402', '0.0.0_0005', '{"lastupdated":"2023-08-29T10:34:39.309","temperature":2492,"temperature_bis":null}', '{"battery":98,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1026],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:524 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1683446122 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0405'
12:08:28:527 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693305279 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0405'
12:08:28:529 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1672902704 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0405'
12:08:28:532 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307248 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0405'
12:08:28:536 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '98', 'dev', 1693166143 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0405'
12:08:28:538 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1682958048 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0405'
12:08:28:542 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('7', 'MultisensorDusche', 'ZHAHumidity', 'lumi.weather', 'LUMI', '00:15:8d:00:07:08:49:2b-01-0405', '0.0.0_0005', '{"humidity":4827,"humidity_bis":null,"lastupdated":"2023-08-29T10:34:39.325"}', '{"battery":98,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1029],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:555 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1683446122 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0403'
12:08:28:558 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693305279 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0403'
12:08:28:560 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1672902704 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0403'
12:08:28:563 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307249 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0403'
12:08:28:567 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '98', 'dev', 1693166143 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0403'
12:08:28:569 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1682958048 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:08:49:2b-01-0403'
12:08:28:573 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('9', 'MultisensorDusche', 'ZHAPressure', 'lumi.weather', 'LUMI', '00:15:8d:00:07:08:49:2b-01-0403', '0.0.0_0005', '{"lastupdated":"2023-08-29T10:34:39.332","pressure":946,"pressure_bis":null}', '{"battery":98,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1027],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:585 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1692911128 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0402'
12:08:28:588 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693306765 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0402'
12:08:28:590 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1672902864 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0402'
12:08:28:593 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307249 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0402'
12:08:28:597 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '100', 'dev', 1693303723 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0402'
12:08:28:599 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1682958048 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0402'
12:08:28:603 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('11', 'MultisensorBad', 'ZHATemperature', 'lumi.weather', 'LUMI', '00:15:8d:00:07:e3:dd:45-01-0402', '0.0.0_0005', '{"lastupdated":"2023-08-29T10:59:26.030","temperature":2494,"temperature_bis":null}', '{"battery":100,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1026],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:616 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1692911128 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0405'
12:08:28:618 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693306765 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0405'
12:08:28:621 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1672902863 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0405'
12:08:28:623 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307249 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0405'
12:08:28:627 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '100', 'dev', 1693303723 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0405'
12:08:28:630 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1682958048 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0405'
12:08:28:634 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('10', 'MultisensorBad', 'ZHAHumidity', 'lumi.weather', 'LUMI', '00:15:8d:00:07:e3:dd:45-01-0405', '0.0.0_0005', '{"humidity":4893,"humidity_bis":null,"lastupdated":"2023-08-29T10:59:26.067"}', '{"battery":100,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1029],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:646 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastannounced', '', 'dev', 1692911128 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0403'
12:08:28:648 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'attr/lastseen', '2023-08-29T11:07Z', 'dev', 1693306765 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0403'
12:08:28:651 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/on', 'true', 'dev', 1672902864 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0403'
12:08:28:653 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/reachable', 'false', 'dev', 1693307249 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0403'
12:08:28:657 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/battery', '100', 'dev', 1693303723 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0403'
12:08:28:660 INSERT INTO resource_items (sub_device_id,item,value,source,timestamp) SELECT id, 'config/offset', '0', 'dev', 1682958048 FROM sub_devices WHERE uniqueid = '00:15:8d:00:07:e3:dd:45-01-0403'
12:08:28:664 DB sql exec REPLACE INTO sensors (sid, name, type, modelid, manufacturername, uniqueid, swversion, state, config, fingerprint, deletedState, mode, lastseen, lastannounced) VALUES ('12', 'MultisensorBad', 'ZHAPressure', 'lumi.weather', 'LUMI', '00:15:8d:00:07:e3:dd:45-01-0403', '0.0.0_0005', '{"lastupdated":"2023-08-29T10:59:26.113","pressure":946,"pressure_bis":null}', '{"battery":100,"offset":0,"on":true,"reachable":false}', '{"d":24321,"ep":1,"in":[0,1027],"p":260}', 'normal', '1', '2023-08-29T11:07Z', '')
12:08:28:739 DB saved in 647 ms

sendtom · August 29, 2023, 11:43am

and part 2:

12:08:29:592 Skip idle timer callback, too early: elapsed 834 msec
12:08:30:424 APS-DATA.request id: 122, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:30:424 	asdu (length: 2): 3c00
12:08:30:492 APS-DATA.confirm id: 122, status: 0x00 SUCCESS
12:08:30:492 APS-DATA.confirm request id: 122 -> confirmed, timeout 7799333
12:08:30:526 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:30:526 	asdu: 3c0005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:30:526 APS-DATA.indication request id: 122 -> finished
12:08:30:526 APS-DATA.request id: 122 erase from queue
12:08:30:527 APS-DATA.request id: 124, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:30:527 	asdu (length: 2): 3d01
12:08:30:592 APS-DATA.confirm id: 124, status: 0x00 SUCCESS
12:08:30:592 APS-DATA.confirm request id: 124 -> confirmed, timeout 7799435
12:08:30:652 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:30:652 	asdu: 3d0005010115520affff2e21002b490807008d150067e6120001f4
12:08:30:652 APS-DATA.indication request id: 124 -> finished
12:08:30:652 APS-DATA.request id: 124 erase from queue
12:08:30:653 APS-DATA.request id: 126, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:30:653 	asdu (length: 2): 3e02
12:08:30:722 APS-DATA.confirm id: 126, status: 0x00 SUCCESS
12:08:30:722 APS-DATA.confirm request id: 126 -> confirmed, timeout 7799561
12:08:30:756 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:30:756 	asdu: 3e0005020115520affff2e21002ad85009008d1500181c120001ff
12:08:30:757 APS-DATA.indication request id: 126 -> finished
12:08:30:757 APS-DATA.request id: 126 erase from queue
12:08:30:757 APS-DATA.request id: 128, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:30:757 	asdu (length: 2): 3f03
12:08:30:822 APS-DATA.confirm id: 128, status: 0x00 SUCCESS
12:08:30:822 APS-DATA.confirm request id: 128 -> confirmed, timeout 7799665
12:08:30:856 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:30:856 	asdu: 3f0005030115520affff2e2100f388e407008d150003b9120001eb
12:08:30:856 APS-DATA.indication request id: 128 -> finished
12:08:30:857 APS-DATA.request id: 128 erase from queue
12:08:30:857 APS-DATA.request id: 130, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:30:857 	asdu (length: 2): 4004
12:08:30:922 APS-DATA.confirm id: 130, status: 0x00 SUCCESS
12:08:30:922 APS-DATA.confirm request id: 130 -> confirmed, timeout 7799765
12:08:30:964 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:30:964 	asdu: 400005040115520affff2e210045dde307008d150085ee120001f9
12:08:30:964 APS-DATA.indication request id: 130 -> finished
12:08:30:964 APS-DATA.request id: 130 erase from queue
12:08:32:093 GW firmware version: 0x26690700
12:08:35:704 APS-DATA.request id: 132, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:35:704 	asdu (length: 2): 4100
12:08:35:762 APS-DATA.confirm id: 132, status: 0x00 SUCCESS
12:08:35:762 APS-DATA.confirm request id: 132 -> confirmed, timeout 7804613
12:08:35:796 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:35:796 	asdu: 410005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:35:796 APS-DATA.indication request id: 132 -> finished
12:08:35:796 APS-DATA.request id: 132 erase from queue
12:08:35:797 APS-DATA.request id: 134, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:35:797 	asdu (length: 2): 4201
12:08:35:862 APS-DATA.confirm id: 134, status: 0x00 SUCCESS
12:08:35:862 APS-DATA.confirm request id: 134 -> confirmed, timeout 7804705
12:08:35:896 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:35:896 	asdu: 420005010115520affff2e21002b490807008d150067e6120001f4
12:08:35:896 APS-DATA.indication request id: 134 -> finished
12:08:35:896 APS-DATA.request id: 134 erase from queue
12:08:35:897 APS-DATA.request id: 136, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:35:897 	asdu (length: 2): 4302
12:08:35:962 APS-DATA.confirm id: 136, status: 0x00 SUCCESS
12:08:35:962 APS-DATA.confirm request id: 136 -> confirmed, timeout 7804805
12:08:35:996 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:35:996 	asdu: 430005020115520affff2e21002ad85009008d1500181c120001ff
12:08:35:996 APS-DATA.indication request id: 136 -> finished
12:08:35:996 APS-DATA.request id: 136 erase from queue
12:08:35:997 APS-DATA.request id: 138, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:35:997 	asdu (length: 2): 4403
12:08:36:062 APS-DATA.confirm id: 138, status: 0x00 SUCCESS
12:08:36:062 APS-DATA.confirm request id: 138 -> confirmed, timeout 7804905
12:08:36:096 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:36:096 	asdu: 440005030115520affff2e2100f388e407008d150003b9120001eb
12:08:36:096 APS-DATA.indication request id: 138 -> finished
12:08:36:096 APS-DATA.request id: 138 erase from queue
12:08:36:097 APS-DATA.request id: 140, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:36:097 	asdu (length: 2): 4504
12:08:36:162 APS-DATA.confirm id: 140, status: 0x00 SUCCESS
12:08:36:162 APS-DATA.confirm request id: 140 -> confirmed, timeout 7805005
12:08:36:196 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:36:196 	asdu: 450005040115520affff2e210045dde307008d150085ee120001f9
12:08:36:196 APS-DATA.indication request id: 140 -> finished
12:08:36:196 APS-DATA.request id: 140 erase from queue
12:08:37:093 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:08:40:984 APS-DATA.request id: 142, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:40:984 	asdu (length: 2): 4600
12:08:41:052 APS-DATA.confirm id: 142, status: 0x00 SUCCESS
12:08:41:052 APS-DATA.confirm request id: 142 -> confirmed, timeout 7809892
12:08:41:086 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:41:086 	asdu: 460005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:41:086 APS-DATA.indication request id: 142 -> finished
12:08:41:086 APS-DATA.request id: 142 erase from queue
12:08:41:087 APS-DATA.request id: 144, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:41:087 	asdu (length: 2): 4701
12:08:41:152 APS-DATA.confirm id: 144, status: 0x00 SUCCESS
12:08:41:152 APS-DATA.confirm request id: 144 -> confirmed, timeout 7809995
12:08:41:197 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:41:198 	asdu: 470005010115520affff2e21002b490807008d150067e6120001f4
12:08:41:198 APS-DATA.indication request id: 144 -> finished
12:08:41:198 APS-DATA.request id: 144 erase from queue
12:08:41:198 APS-DATA.request id: 146, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:41:198 	asdu (length: 2): 4802
12:08:41:262 APS-DATA.confirm id: 146, status: 0x00 SUCCESS
12:08:41:262 APS-DATA.confirm request id: 146 -> confirmed, timeout 7810106
12:08:41:302 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:41:302 	asdu: 480005020115520affff2e21002ad85009008d1500181c120001ff
12:08:41:302 APS-DATA.indication request id: 146 -> finished
12:08:41:302 APS-DATA.request id: 146 erase from queue
12:08:41:303 APS-DATA.request id: 148, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:41:303 	asdu (length: 2): 4903
12:08:41:362 APS-DATA.confirm id: 148, status: 0x00 SUCCESS
12:08:41:362 APS-DATA.confirm request id: 148 -> confirmed, timeout 7810211
12:08:41:392 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:41:392 	asdu: 490005030115520affff2e2100f388e407008d150003b9120001eb
12:08:41:392 APS-DATA.indication request id: 148 -> finished
12:08:41:392 APS-DATA.request id: 148 erase from queue
12:08:41:393 APS-DATA.request id: 150, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:41:393 	asdu (length: 2): 4a04
12:08:41:452 APS-DATA.confirm id: 150, status: 0x00 SUCCESS
12:08:41:452 APS-DATA.confirm request id: 150 -> confirmed, timeout 7810301
12:08:41:492 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:41:492 	asdu: 4a0005040115520affff2e210045dde307008d150085ee120001f9
12:08:41:492 APS-DATA.indication request id: 150 -> finished
12:08:41:492 APS-DATA.request id: 150 erase from queue
12:08:42:093 GW firmware version: 0x26690700
12:08:46:264 APS-DATA.request id: 152, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:46:264 	asdu (length: 2): 4b00
12:08:46:332 APS-DATA.confirm id: 152, status: 0x00 SUCCESS
12:08:46:332 APS-DATA.confirm request id: 152 -> confirmed, timeout 7815172
12:08:46:366 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:46:366 	asdu: 4b0005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:46:366 APS-DATA.indication request id: 152 -> finished
12:08:46:366 APS-DATA.request id: 152 erase from queue
12:08:46:367 APS-DATA.request id: 154, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:46:367 	asdu (length: 2): 4c01
12:08:46:432 APS-DATA.confirm id: 154, status: 0x00 SUCCESS
12:08:46:432 APS-DATA.confirm request id: 154 -> confirmed, timeout 7815275
12:08:46:477 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:46:477 	asdu: 4c0005010115520affff2e21002b490807008d150067e6120001f4
12:08:46:477 APS-DATA.indication request id: 154 -> finished
12:08:46:477 APS-DATA.request id: 154 erase from queue
12:08:46:478 APS-DATA.request id: 156, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:46:478 	asdu (length: 2): 4d02
12:08:46:552 APS-DATA.confirm id: 156, status: 0x00 SUCCESS
12:08:46:552 APS-DATA.confirm request id: 156 -> confirmed, timeout 7815386
12:08:46:592 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:46:592 	asdu: 4d0005020115520affff2e21002ad85009008d1500181c120001ff
12:08:46:592 APS-DATA.indication request id: 156 -> finished
12:08:46:592 APS-DATA.request id: 156 erase from queue
12:08:46:593 APS-DATA.request id: 158, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:46:593 	asdu (length: 2): 4e03
12:08:46:652 APS-DATA.confirm id: 158, status: 0x00 SUCCESS
12:08:46:652 APS-DATA.confirm request id: 158 -> confirmed, timeout 7815501
12:08:46:683 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:46:683 	asdu: 4e0005030115520affff2e2100f388e407008d150003b9120001eb
12:08:46:683 APS-DATA.indication request id: 158 -> finished
12:08:46:683 APS-DATA.request id: 158 erase from queue
12:08:46:683 APS-DATA.request id: 160, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:46:683 	asdu (length: 2): 4f04
12:08:46:742 APS-DATA.confirm id: 160, status: 0x00 SUCCESS
12:08:46:742 APS-DATA.confirm request id: 160 -> confirmed, timeout 7815591
12:08:46:782 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:46:782 	asdu: 4f0005040115520affff2e210045dde307008d150085ee120001f9
12:08:46:783 APS-DATA.indication request id: 160 -> finished
12:08:46:783 APS-DATA.request id: 160 erase from queue
12:08:47:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:08:49:593 Idle timer triggered
12:08:51:545 APS-DATA.request id: 162, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:51:545 	asdu (length: 2): 5000
12:08:51:612 APS-DATA.confirm id: 162, status: 0x00 SUCCESS
12:08:51:612 APS-DATA.confirm request id: 162 -> confirmed, timeout 7820453
12:08:51:672 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:51:672 	asdu: 500005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:51:672 APS-DATA.indication request id: 162 -> finished
12:08:51:672 APS-DATA.request id: 162 erase from queue
12:08:51:673 APS-DATA.request id: 164, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:51:673 	asdu (length: 2): 5101
12:08:51:742 APS-DATA.confirm id: 164, status: 0x00 SUCCESS
12:08:51:742 APS-DATA.confirm request id: 164 -> confirmed, timeout 7820581
12:08:51:776 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:51:776 	asdu: 510005010115520affff2e21002b490807008d150067e6120001f4
12:08:51:776 APS-DATA.indication request id: 164 -> finished
12:08:51:776 APS-DATA.request id: 164 erase from queue
12:08:51:777 APS-DATA.request id: 166, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:51:777 	asdu (length: 2): 5202
12:08:51:842 APS-DATA.confirm id: 166, status: 0x00 SUCCESS
12:08:51:842 APS-DATA.confirm request id: 166 -> confirmed, timeout 7820685
12:08:51:876 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:51:876 	asdu: 520005020115520affff2e21002ad85009008d1500181c120001ff
12:08:51:876 APS-DATA.indication request id: 166 -> finished
12:08:51:876 APS-DATA.request id: 166 erase from queue
12:08:51:877 APS-DATA.request id: 168, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:51:877 	asdu (length: 2): 5303
12:08:51:942 APS-DATA.confirm id: 168, status: 0x00 SUCCESS
12:08:51:942 APS-DATA.confirm request id: 168 -> confirmed, timeout 7820785
12:08:51:982 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:51:982 	asdu: 530005030115520affff2e2100f388e407008d150003b9120001eb
12:08:51:982 APS-DATA.indication request id: 168 -> finished
12:08:51:982 APS-DATA.request id: 168 erase from queue
12:08:51:982 APS-DATA.request id: 170, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:51:982 	asdu (length: 2): 5404
12:08:52:042 APS-DATA.confirm id: 170, status: 0x00 SUCCESS
12:08:52:042 APS-DATA.confirm request id: 170 -> confirmed, timeout 7820891
12:08:52:075 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:52:075 	asdu: 540005040115520affff2e210045dde307008d150085ee120001f9
12:08:52:075 APS-DATA.indication request id: 170 -> finished
12:08:52:075 APS-DATA.request id: 170 erase from queue
12:08:52:093 GW firmware version: 0x26690700
12:08:52:592 Skip idle timer callback, too early: elapsed 949 msec
12:08:56:825 APS-DATA.request id: 172, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:56:825 	asdu (length: 2): 5500
12:08:56:892 APS-DATA.confirm id: 172, status: 0x00 SUCCESS
12:08:56:892 APS-DATA.confirm request id: 172 -> confirmed, timeout 7825733
12:08:56:926 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:56:926 	asdu: 550005000115520affff2e210073f0e207008d15008fbe120001fc
12:08:56:926 APS-DATA.indication request id: 172 -> finished
12:08:56:926 APS-DATA.request id: 172 erase from queue
12:08:56:927 APS-DATA.request id: 174, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:56:927 	asdu (length: 2): 5601
12:08:56:992 APS-DATA.confirm id: 174, status: 0x00 SUCCESS
12:08:56:992 APS-DATA.confirm request id: 174 -> confirmed, timeout 7825835
12:08:57:026 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:57:026 	asdu: 560005010115520affff2e21002b490807008d150067e6120001f4
12:08:57:026 APS-DATA.indication request id: 174 -> finished
12:08:57:026 APS-DATA.request id: 174 erase from queue
12:08:57:027 APS-DATA.request id: 176, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:57:027 	asdu (length: 2): 5702
12:08:57:092 APS-DATA.confirm id: 176, status: 0x00 SUCCESS
12:08:57:092 APS-DATA.confirm request id: 176 -> confirmed, timeout 7825935
12:08:57:122 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:08:57:152 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:57:152 	asdu: 570005020115520affff2e21002ad85009008d1500181c120001ff
12:08:57:152 APS-DATA.indication request id: 176 -> finished
12:08:57:152 APS-DATA.request id: 176 erase from queue
12:08:57:152 APS-DATA.request id: 178, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:57:153 	asdu (length: 2): 5803
12:08:57:222 APS-DATA.confirm id: 178, status: 0x00 SUCCESS
12:08:57:222 APS-DATA.confirm request id: 178 -> confirmed, timeout 7826061
12:08:57:256 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:57:256 	asdu: 580005030115520affff2e2100f388e407008d150003b9120001eb
12:08:57:256 APS-DATA.indication request id: 178 -> finished
12:08:57:257 APS-DATA.request id: 178 erase from queue
12:08:57:257 APS-DATA.request id: 180, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:08:57:257 	asdu (length: 2): 5904
12:08:57:322 APS-DATA.confirm id: 180, status: 0x00 SUCCESS
12:08:57:322 APS-DATA.confirm request id: 180 -> confirmed, timeout 7826165
12:08:57:360 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:08:57:360 	asdu: 590005040115520affff2e210045dde307008d150085ee120001f9
12:08:57:361 APS-DATA.indication request id: 180 -> finished
12:08:57:361 APS-DATA.request id: 180 erase from queue
12:09:02:093 GW firmware version: 0x26690700
12:09:02:104 APS-DATA.request id: 182, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:02:104 	asdu (length: 2): 5a00
12:09:02:172 APS-DATA.confirm id: 182, status: 0x00 SUCCESS
12:09:02:172 APS-DATA.confirm request id: 182 -> confirmed, timeout 7831012
12:09:02:206 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:02:206 	asdu: 5a0005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:02:206 APS-DATA.indication request id: 182 -> finished
12:09:02:207 APS-DATA.request id: 182 erase from queue
12:09:02:207 APS-DATA.request id: 184, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:02:207 	asdu (length: 2): 5b01
12:09:02:272 APS-DATA.confirm id: 184, status: 0x00 SUCCESS
12:09:02:272 APS-DATA.confirm request id: 184 -> confirmed, timeout 7831115
12:09:02:306 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:02:306 	asdu: 5b0005010115520affff2e21002b490807008d150067e6120001f4
12:09:02:306 APS-DATA.indication request id: 184 -> finished
12:09:02:307 APS-DATA.request id: 184 erase from queue
12:09:02:307 APS-DATA.request id: 186, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:02:307 	asdu (length: 2): 5c02
12:09:02:372 APS-DATA.confirm id: 186, status: 0x00 SUCCESS
12:09:02:372 APS-DATA.confirm request id: 186 -> confirmed, timeout 7831215
12:09:02:412 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:02:412 	asdu: 5c0005020115520affff2e21002ad85009008d1500181c120001ff
12:09:02:412 APS-DATA.indication request id: 186 -> finished
12:09:02:413 APS-DATA.request id: 186 erase from queue
12:09:02:413 APS-DATA.request id: 188, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:02:413 	asdu (length: 2): 5d03
12:09:02:472 APS-DATA.confirm id: 188, status: 0x00 SUCCESS
12:09:02:472 APS-DATA.confirm request id: 188 -> confirmed, timeout 7831321
12:09:02:502 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:02:502 	asdu: 5d0005030115520affff2e2100f388e407008d150003b9120001eb
12:09:02:502 APS-DATA.indication request id: 188 -> finished
12:09:02:502 APS-DATA.request id: 188 erase from queue
12:09:02:503 APS-DATA.request id: 190, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:02:503 	asdu (length: 2): 5e04
12:09:02:572 APS-DATA.confirm id: 190, status: 0x00 SUCCESS
12:09:02:572 APS-DATA.confirm request id: 190 -> confirmed, timeout 7831411
12:09:02:602 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:02:602 	asdu: 5e0005040115520affff2e210045dde307008d150085ee120001f9
12:09:02:603 APS-DATA.indication request id: 190 -> finished
12:09:02:603 APS-DATA.request id: 190 erase from queue
12:09:07:093 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:09:07:384 APS-DATA.request id: 192, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:07:384 	asdu (length: 2): 5f00
12:09:07:452 APS-DATA.confirm id: 192, status: 0x00 SUCCESS
12:09:07:452 APS-DATA.confirm request id: 192 -> confirmed, timeout 7836292
12:09:07:492 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:07:492 	asdu: 5f0005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:07:492 APS-DATA.indication request id: 192 -> finished
12:09:07:492 APS-DATA.request id: 192 erase from queue
12:09:07:492 APS-DATA.request id: 194, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:07:493 	asdu (length: 2): 6001
12:09:07:552 APS-DATA.confirm id: 194, status: 0x00 SUCCESS
12:09:07:552 APS-DATA.confirm request id: 194 -> confirmed, timeout 7836401
12:09:07:582 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:07:582 	asdu: 600005010115520affff2e21002b490807008d150067e6120001f4
12:09:07:582 APS-DATA.indication request id: 194 -> finished
12:09:07:582 APS-DATA.request id: 194 erase from queue
12:09:07:583 APS-DATA.request id: 196, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:07:583 	asdu (length: 2): 6102
12:09:07:652 APS-DATA.confirm id: 196, status: 0x00 SUCCESS
12:09:07:652 APS-DATA.confirm request id: 196 -> confirmed, timeout 7836491
12:09:07:682 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:07:682 	asdu: 610005020115520affff2e21002ad85009008d1500181c120001ff
12:09:07:682 APS-DATA.indication request id: 196 -> finished
12:09:07:683 APS-DATA.request id: 196 erase from queue
12:09:07:683 APS-DATA.request id: 198, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:07:683 	asdu (length: 2): 6203
12:09:07:742 APS-DATA.confirm id: 198, status: 0x00 SUCCESS
12:09:07:742 APS-DATA.confirm request id: 198 -> confirmed, timeout 7836591
12:09:07:772 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:07:772 	asdu: 620005030115520affff2e2100f388e407008d150003b9120001eb
12:09:07:772 APS-DATA.indication request id: 198 -> finished
12:09:07:772 APS-DATA.request id: 198 erase from queue
12:09:07:773 APS-DATA.request id: 200, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:07:773 	asdu (length: 2): 6304
12:09:07:832 APS-DATA.confirm id: 200, status: 0x00 SUCCESS
12:09:07:832 APS-DATA.confirm request id: 200 -> confirmed, timeout 7836681
12:09:07:862 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:07:862 	asdu: 630005040115520affff2e210045dde307008d150085ee120001f9
12:09:07:862 APS-DATA.indication request id: 200 -> finished
12:09:07:862 APS-DATA.request id: 200 erase from queue
12:09:12:092 GW firmware version: 0x26690700
12:09:12:665 APS-DATA.request id: 202, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:12:665 	asdu (length: 2): 6400
12:09:12:732 APS-DATA.confirm id: 202, status: 0x00 SUCCESS
12:09:12:732 APS-DATA.confirm request id: 202 -> confirmed, timeout 7841573
12:09:12:766 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:12:766 	asdu: 640005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:12:766 APS-DATA.indication request id: 202 -> finished
12:09:12:766 APS-DATA.request id: 202 erase from queue
12:09:12:767 APS-DATA.request id: 204, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:12:767 	asdu (length: 2): 6501
12:09:12:832 APS-DATA.confirm id: 204, status: 0x00 SUCCESS
12:09:12:832 APS-DATA.confirm request id: 204 -> confirmed, timeout 7841675
12:09:12:875 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:12:875 	asdu: 650005010115520affff2e21002b490807008d150067e6120001f4
12:09:12:875 APS-DATA.indication request id: 204 -> finished
12:09:12:875 APS-DATA.request id: 204 erase from queue
12:09:12:875 APS-DATA.request id: 206, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:12:875 	asdu (length: 2): 6602
12:09:12:942 APS-DATA.confirm id: 206, status: 0x00 SUCCESS
12:09:12:942 APS-DATA.confirm request id: 206 -> confirmed, timeout 7841785
12:09:12:976 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:12:976 	asdu: 660005020115520affff2e21002ad85009008d1500181c120001ff
12:09:12:976 APS-DATA.indication request id: 206 -> finished
12:09:12:976 APS-DATA.request id: 206 erase from queue
12:09:12:977 APS-DATA.request id: 208, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:12:977 	asdu (length: 2): 6703
12:09:13:042 APS-DATA.confirm id: 208, status: 0x00 SUCCESS
12:09:13:042 APS-DATA.confirm request id: 208 -> confirmed, timeout 7841885
12:09:13:076 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:13:076 	asdu: 670005030115520affff2e2100f388e407008d150003b9120001eb
12:09:13:076 APS-DATA.indication request id: 208 -> finished
12:09:13:076 APS-DATA.request id: 208 erase from queue
12:09:13:077 APS-DATA.request id: 210, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:13:077 	asdu (length: 2): 6804
12:09:13:142 APS-DATA.confirm id: 210, status: 0x00 SUCCESS
12:09:13:142 APS-DATA.confirm request id: 210 -> confirmed, timeout 7841985
12:09:13:176 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:13:176 	asdu: 680005040115520affff2e210045dde307008d150085ee120001f9
12:09:13:176 APS-DATA.indication request id: 210 -> finished
12:09:13:176 APS-DATA.request id: 210 erase from queue
12:09:17:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:09:17:944 APS-DATA.request id: 212, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:17:944 	asdu (length: 2): 6900
12:09:18:012 APS-DATA.confirm id: 212, status: 0x00 SUCCESS
12:09:18:012 APS-DATA.confirm request id: 212 -> confirmed, timeout 7846853
12:09:18:052 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:18:052 	asdu: 690005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:18:052 APS-DATA.indication request id: 212 -> finished
12:09:18:052 APS-DATA.request id: 212 erase from queue
12:09:18:052 APS-DATA.request id: 214, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:18:053 	asdu (length: 2): 6a01
12:09:18:112 APS-DATA.confirm id: 214, status: 0x00 SUCCESS
12:09:18:112 APS-DATA.confirm request id: 214 -> confirmed, timeout 7846961
12:09:18:142 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:18:142 	asdu: 6a0005010115520affff2e21002b490807008d150067e6120001f4
12:09:18:142 APS-DATA.indication request id: 214 -> finished
12:09:18:142 APS-DATA.request id: 214 erase from queue
12:09:18:143 APS-DATA.request id: 216, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:18:143 	asdu (length: 2): 6b02
12:09:18:202 APS-DATA.confirm id: 216, status: 0x00 SUCCESS
12:09:18:202 APS-DATA.confirm request id: 216 -> confirmed, timeout 7847051
12:09:18:232 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:18:232 	asdu: 6b0005020115520affff2e21002ad85009008d1500181c120001ff
12:09:18:232 APS-DATA.indication request id: 216 -> finished
12:09:18:232 APS-DATA.request id: 216 erase from queue
12:09:18:233 APS-DATA.request id: 218, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:18:233 	asdu (length: 2): 6c03
12:09:18:292 APS-DATA.confirm id: 218, status: 0x00 SUCCESS
12:09:18:292 APS-DATA.confirm request id: 218 -> confirmed, timeout 7847141
12:09:18:332 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:18:332 	asdu: 6c0005030115520affff2e2100f388e407008d150003b9120001eb
12:09:18:332 APS-DATA.indication request id: 218 -> finished
12:09:18:332 APS-DATA.request id: 218 erase from queue
12:09:18:333 APS-DATA.request id: 220, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:18:333 	asdu (length: 2): 6d04
12:09:18:392 APS-DATA.confirm id: 220, status: 0x00 SUCCESS
12:09:18:392 APS-DATA.confirm request id: 220 -> confirmed, timeout 7847241
12:09:18:422 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:18:422 	asdu: 6d0005040115520affff2e210045dde307008d150085ee120001f9
12:09:18:422 APS-DATA.indication request id: 220 -> finished
12:09:18:422 APS-DATA.request id: 220 erase from queue
12:09:20:592 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1
12:09:20:593 Idle timer triggered
12:09:22:093 GW firmware version: 0x26690700
12:09:23:224 APS-DATA.request id: 222, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:23:224 	asdu (length: 2): 6e00
12:09:23:292 APS-DATA.confirm id: 222, status: 0x00 SUCCESS
12:09:23:292 APS-DATA.confirm request id: 222 -> confirmed, timeout 7852133
12:09:23:326 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:23:326 	asdu: 6e0005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:23:326 APS-DATA.indication request id: 222 -> finished
12:09:23:326 APS-DATA.request id: 222 erase from queue
12:09:23:327 APS-DATA.request id: 224, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:23:327 	asdu (length: 2): 6f01
12:09:23:392 APS-DATA.confirm id: 224, status: 0x00 SUCCESS
12:09:23:392 APS-DATA.confirm request id: 224 -> confirmed, timeout 7852235
12:09:23:426 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:23:426 	asdu: 6f0005010115520affff2e21002b490807008d150067e6120001f4
12:09:23:426 APS-DATA.indication request id: 224 -> finished
12:09:23:426 APS-DATA.request id: 224 erase from queue
12:09:23:427 APS-DATA.request id: 226, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:23:427 	asdu (length: 2): 7002
12:09:23:492 APS-DATA.confirm id: 226, status: 0x00 SUCCESS
12:09:23:492 APS-DATA.confirm request id: 226 -> confirmed, timeout 7852335
12:09:23:526 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:23:526 	asdu: 700005020115520affff2e21002ad85009008d1500181c120001ff
12:09:23:526 APS-DATA.indication request id: 226 -> finished
12:09:23:526 APS-DATA.request id: 226 erase from queue
12:09:23:527 APS-DATA.request id: 228, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:23:527 	asdu (length: 2): 7103
12:09:23:602 APS-DATA.confirm id: 228, status: 0x00 SUCCESS
12:09:23:602 APS-DATA.confirm request id: 228 -> confirmed, timeout 7852435
12:09:23:632 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:23:632 	asdu: 710005030115520affff2e2100f388e407008d150003b9120001eb
12:09:23:632 APS-DATA.indication request id: 228 -> finished
12:09:23:633 APS-DATA.request id: 228 erase from queue
12:09:23:633 APS-DATA.request id: 230, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:23:633 	asdu (length: 2): 7204
12:09:23:702 APS-DATA.confirm id: 230, status: 0x00 SUCCESS
12:09:23:702 APS-DATA.confirm request id: 230 -> confirmed, timeout 7852541
12:09:23:736 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:23:736 	asdu: 720005040115520affff2e210045dde307008d150085ee120001f9
12:09:23:736 APS-DATA.indication request id: 230 -> finished
12:09:23:737 APS-DATA.request id: 230 erase from queue
12:09:27:093 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:09:28:504 APS-DATA.request id: 232, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:28:505 	asdu (length: 2): 7300
12:09:28:572 APS-DATA.confirm id: 232, status: 0x00 SUCCESS
12:09:28:572 APS-DATA.confirm request id: 232 -> confirmed, timeout 7857413
12:09:28:606 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:28:606 	asdu: 730005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:28:606 APS-DATA.indication request id: 232 -> finished
12:09:28:607 APS-DATA.request id: 232 erase from queue
12:09:28:607 APS-DATA.request id: 234, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:28:607 	asdu (length: 2): 7401
12:09:28:692 APS-DATA.confirm id: 234, status: 0x00 SUCCESS
12:09:28:692 APS-DATA.confirm request id: 234 -> confirmed, timeout 7857515
12:09:28:722 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:28:722 	asdu: 740005010115520affff2e21002b490807008d150067e6120001f4
12:09:28:722 APS-DATA.indication request id: 234 -> finished
12:09:28:722 APS-DATA.request id: 234 erase from queue
12:09:28:723 APS-DATA.request id: 236, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:28:723 	asdu (length: 2): 7502
12:09:28:782 APS-DATA.confirm id: 236, status: 0x00 SUCCESS
12:09:28:782 APS-DATA.confirm request id: 236 -> confirmed, timeout 7857631
12:09:28:812 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:28:812 	asdu: 750005020115520affff2e21002ad85009008d1500181c120001ff
12:09:28:812 APS-DATA.indication request id: 236 -> finished
12:09:28:812 APS-DATA.request id: 236 erase from queue
12:09:28:813 APS-DATA.request id: 238, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:28:813 	asdu (length: 2): 7603
12:09:28:872 APS-DATA.confirm id: 238, status: 0x00 SUCCESS
12:09:28:872 APS-DATA.confirm request id: 238 -> confirmed, timeout 7857721
12:09:28:902 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:28:902 	asdu: 760005030115520affff2e2100f388e407008d150003b9120001eb
12:09:28:902 APS-DATA.indication request id: 238 -> finished
12:09:28:902 APS-DATA.request id: 238 erase from queue
12:09:28:902 APS-DATA.request id: 240, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:28:903 	asdu (length: 2): 7704
12:09:28:962 APS-DATA.confirm id: 240, status: 0x00 SUCCESS
12:09:28:962 APS-DATA.confirm request id: 240 -> confirmed, timeout 7857811
12:09:28:992 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:28:992 	asdu: 770005040115520affff2e210045dde307008d150085ee120001f9
12:09:28:992 APS-DATA.indication request id: 240 -> finished
12:09:28:992 APS-DATA.request id: 240 erase from queue
12:09:32:092 GW firmware version: 0x26690700
12:09:33:784 APS-DATA.request id: 242, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:33:785 	asdu (length: 2): 7800
12:09:33:852 APS-DATA.confirm id: 242, status: 0x00 SUCCESS
12:09:33:852 APS-DATA.confirm request id: 242 -> confirmed, timeout 7862693
12:09:33:886 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:33:886 	asdu: 780005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:33:887 APS-DATA.indication request id: 242 -> finished
12:09:33:887 APS-DATA.request id: 242 erase from queue
12:09:33:887 APS-DATA.request id: 244, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:33:887 	asdu (length: 2): 7901
12:09:33:952 APS-DATA.confirm id: 244, status: 0x00 SUCCESS
12:09:33:952 APS-DATA.confirm request id: 244 -> confirmed, timeout 7862795
12:09:33:986 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:33:986 	asdu: 790005010115520affff2e21002b490807008d150067e6120001f4
12:09:33:986 APS-DATA.indication request id: 244 -> finished
12:09:33:987 APS-DATA.request id: 244 erase from queue
12:09:33:987 APS-DATA.request id: 246, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:33:987 	asdu (length: 2): 7a02
12:09:34:062 APS-DATA.confirm id: 246, status: 0x00 SUCCESS
12:09:34:062 APS-DATA.confirm request id: 246 -> confirmed, timeout 7862895
12:09:34:096 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:34:097 	asdu: 7a0005020115520affff2e21002ad85009008d1500181c120001ff
12:09:34:097 APS-DATA.indication request id: 246 -> finished
12:09:34:097 APS-DATA.request id: 246 erase from queue
12:09:34:097 APS-DATA.request id: 248, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:34:097 	asdu (length: 2): 7b03
12:09:34:182 APS-DATA.confirm id: 248, status: 0x00 SUCCESS
12:09:34:182 APS-DATA.confirm request id: 248 -> confirmed, timeout 7863005
12:09:34:212 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:34:212 	asdu: 7b0005030115520affff2e2100f388e407008d150003b9120001eb
12:09:34:212 APS-DATA.indication request id: 248 -> finished
12:09:34:212 APS-DATA.request id: 248 erase from queue
12:09:34:213 APS-DATA.request id: 250, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:34:213 	asdu (length: 2): 7c04
12:09:34:282 APS-DATA.confirm id: 250, status: 0x00 SUCCESS
12:09:34:282 APS-DATA.confirm request id: 250 -> confirmed, timeout 7863121
12:09:34:312 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:34:312 	asdu: 7c0005040115520affff2e210045dde307008d150085ee120001f9
12:09:34:312 APS-DATA.indication request id: 250 -> finished
12:09:34:312 APS-DATA.request id: 250 erase from queue
12:09:37:093 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:09:39:064 APS-DATA.request id: 252, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:39:064 	asdu (length: 2): 7d00
12:09:39:132 APS-DATA.confirm id: 252, status: 0x00 SUCCESS
12:09:39:132 APS-DATA.confirm request id: 252 -> confirmed, timeout 7867972
12:09:39:172 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:39:172 	asdu: 7d0005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:39:172 APS-DATA.indication request id: 252 -> finished
12:09:39:172 APS-DATA.request id: 252 erase from queue
12:09:39:172 APS-DATA.request id: 254, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:39:172 	asdu (length: 2): 7e01
12:09:39:232 APS-DATA.confirm id: 254, status: 0x00 SUCCESS
12:09:39:232 APS-DATA.confirm request id: 254 -> confirmed, timeout 7868081
12:09:39:262 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:39:262 	asdu: 7e0005010115520affff2e21002b490807008d150067e6120001f4
12:09:39:262 APS-DATA.indication request id: 254 -> finished
12:09:39:262 APS-DATA.request id: 254 erase from queue
12:09:39:263 APS-DATA.request id: 0, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:39:263 	asdu (length: 2): 7f02
12:09:39:342 APS-DATA.confirm id: 0, status: 0x00 SUCCESS
12:09:39:342 APS-DATA.confirm request id: 0 -> confirmed, timeout 7868171
12:09:39:372 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:39:372 	asdu: 7f0005020115520affff2e21002ad85009008d1500181c120001ff
12:09:39:373 APS-DATA.indication request id: 0 -> finished
12:09:39:373 APS-DATA.request id: 0 erase from queue
12:09:39:373 APS-DATA.request id: 2, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:39:373 	asdu (length: 2): 8003
12:09:39:432 APS-DATA.confirm id: 2, status: 0x00 SUCCESS
12:09:39:432 APS-DATA.confirm request id: 2 -> confirmed, timeout 7868281
12:09:39:472 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:39:472 	asdu: 800005030115520affff2e2100f388e407008d150003b9120001eb
12:09:39:472 APS-DATA.indication request id: 2 -> finished
12:09:39:472 APS-DATA.request id: 2 erase from queue
12:09:39:472 APS-DATA.request id: 4, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:39:473 	asdu (length: 2): 8104
12:09:39:532 APS-DATA.confirm id: 4, status: 0x00 SUCCESS
12:09:39:532 APS-DATA.confirm request id: 4 -> confirmed, timeout 7868381
12:09:39:562 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:39:562 	asdu: 810005040115520affff2e210045dde307008d150085ee120001f9
12:09:39:562 APS-DATA.indication request id: 4 -> finished
12:09:39:563 APS-DATA.request id: 4 erase from queue
12:09:42:093 GW firmware version: 0x26690700
12:09:44:345 APS-DATA.request id: 6, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:44:345 	asdu (length: 2): 8200
12:09:44:412 APS-DATA.confirm id: 6, status: 0x00 SUCCESS
12:09:44:412 APS-DATA.confirm request id: 6 -> confirmed, timeout 7873253
12:09:44:452 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:44:452 	asdu: 820005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:44:452 APS-DATA.indication request id: 6 -> finished
12:09:44:452 APS-DATA.request id: 6 erase from queue
12:09:44:453 APS-DATA.request id: 8, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:44:453 	asdu (length: 2): 8301
12:09:44:533 APS-DATA.confirm id: 8, status: 0x00 SUCCESS
12:09:44:533 APS-DATA.confirm request id: 8 -> confirmed, timeout 7873361
12:09:44:569 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 231, rssi: -65
12:09:44:570 	asdu: 830005010115520affff2e21002b490807008d150067e6120001f4
12:09:44:570 APS-DATA.indication request id: 8 -> finished
12:09:44:570 APS-DATA.request id: 8 erase from queue
12:09:44:571 APS-DATA.request id: 10, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:44:571 	asdu (length: 2): 8402
12:09:44:632 APS-DATA.confirm id: 10, status: 0x00 SUCCESS
12:09:44:632 APS-DATA.confirm request id: 10 -> confirmed, timeout 7873479
12:09:44:666 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:44:666 	asdu: 840005020115520affff2e21002ad85009008d1500181c120001ff
12:09:44:666 APS-DATA.indication request id: 10 -> finished
12:09:44:666 APS-DATA.request id: 10 erase from queue
12:09:44:667 APS-DATA.request id: 12, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:44:667 	asdu (length: 2): 8503
12:09:44:732 APS-DATA.confirm id: 12, status: 0x00 SUCCESS
12:09:44:732 APS-DATA.confirm request id: 12 -> confirmed, timeout 7873575
12:09:44:766 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:44:766 	asdu: 850005030115520affff2e2100f388e407008d150003b9120001eb
12:09:44:766 APS-DATA.indication request id: 12 -> finished
12:09:44:766 APS-DATA.request id: 12 erase from queue
12:09:44:766 APS-DATA.request id: 14, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:44:767 	asdu (length: 2): 8604
12:09:44:832 APS-DATA.confirm id: 14, status: 0x00 SUCCESS
12:09:44:832 APS-DATA.confirm request id: 14 -> confirmed, timeout 7873675
12:09:44:866 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:44:866 	asdu: 860005040115520affff2e210045dde307008d150085ee120001f9
12:09:44:866 APS-DATA.indication request id: 14 -> finished
12:09:44:866 APS-DATA.request id: 14 erase from queue
12:09:47:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:09:49:624 APS-DATA.request id: 16, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:49:624 	asdu (length: 2): 8700
12:09:49:692 APS-DATA.confirm id: 16, status: 0x00 SUCCESS
12:09:49:692 APS-DATA.confirm request id: 16 -> confirmed, timeout 7878533
12:09:49:726 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:49:726 	asdu: 870005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:49:726 APS-DATA.indication request id: 16 -> finished
12:09:49:726 APS-DATA.request id: 16 erase from queue
12:09:49:727 APS-DATA.request id: 18, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:49:727 	asdu (length: 2): 8801
12:09:49:792 APS-DATA.confirm id: 18, status: 0x00 SUCCESS
12:09:49:792 APS-DATA.confirm request id: 18 -> confirmed, timeout 7878635
12:09:49:832 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:49:832 	asdu: 880005010115520affff2e21002b490807008d150067e6120001f4
12:09:49:832 APS-DATA.indication request id: 18 -> finished
12:09:49:832 APS-DATA.request id: 18 erase from queue
12:09:49:832 APS-DATA.request id: 20, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:49:832 	asdu (length: 2): 8902
12:09:49:892 APS-DATA.confirm id: 20, status: 0x00 SUCCESS
12:09:49:892 APS-DATA.confirm request id: 20 -> confirmed, timeout 7878741
12:09:49:922 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:49:922 	asdu: 890005020115520affff2e21002ad85009008d1500181c120001ff
12:09:49:923 APS-DATA.indication request id: 20 -> finished
12:09:49:923 APS-DATA.request id: 20 erase from queue
12:09:49:923 APS-DATA.request id: 22, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:49:923 	asdu (length: 2): 8a03
12:09:49:983 APS-DATA.confirm id: 22, status: 0x00 SUCCESS
12:09:49:983 APS-DATA.confirm request id: 22 -> confirmed, timeout 7878831
12:09:50:012 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:50:012 	asdu: 8a0005030115520affff2e2100f388e407008d150003b9120001eb
12:09:50:012 APS-DATA.indication request id: 22 -> finished
12:09:50:013 APS-DATA.request id: 22 erase from queue
12:09:50:013 APS-DATA.request id: 24, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:50:013 	asdu (length: 2): 8b04
12:09:50:072 APS-DATA.confirm id: 24, status: 0x00 SUCCESS
12:09:50:072 APS-DATA.confirm request id: 24 -> confirmed, timeout 7878921
12:09:50:102 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:50:102 	asdu: 8b0005040115520affff2e210045dde307008d150085ee120001f9
12:09:50:102 APS-DATA.indication request id: 24 -> finished
12:09:50:102 APS-DATA.request id: 24 erase from queue
12:09:50:592 Idle timer triggered
12:09:52:093 GW firmware version: 0x26690700
12:09:53:969 Websocket disconnected 10.15.4.240:50908, state: 0, close-code: 1001, reason: Shutdown
12:09:54:904 APS-DATA.request id: 26, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:54:904 	asdu (length: 2): 8c00
12:09:54:972 APS-DATA.confirm id: 26, status: 0x00 SUCCESS
12:09:54:972 APS-DATA.confirm request id: 26 -> confirmed, timeout 7883812
12:09:54:006 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:54:006 	asdu: 8c0005000115520affff2e210073f0e207008d15008fbe120001fc
12:09:54:006 APS-DATA.indication request id: 26 -> finished
12:09:54:006 APS-DATA.request id: 26 erase from queue
12:09:54:007 APS-DATA.request id: 28, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:54:007 	asdu (length: 2): 8d01
12:09:55:072 APS-DATA.confirm id: 28, status: 0x00 SUCCESS
12:09:55:072 APS-DATA.confirm request id: 28 -> confirmed, timeout 7883915
12:09:55:106 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:55:106 	asdu: 8d0005010115520affff2e21002b490807008d150067e6120001f4
12:09:55:106 APS-DATA.indication request id: 28 -> finished
12:09:55:106 APS-DATA.request id: 28 erase from queue
12:09:55:106 APS-DATA.request id: 30, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:55:107 	asdu (length: 2): 8e02
12:09:55:172 APS-DATA.confirm id: 30, status: 0x00 SUCCESS
12:09:55:172 APS-DATA.confirm request id: 30 -> confirmed, timeout 7884015
12:09:55:206 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:55:206 	asdu: 8e0005020115520affff2e21002ad85009008d1500181c120001ff
12:09:55:206 APS-DATA.indication request id: 30 -> finished
12:09:55:206 APS-DATA.request id: 30 erase from queue
12:09:55:207 APS-DATA.request id: 32, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:55:207 	asdu (length: 2): 8f03
12:09:55:282 APS-DATA.confirm id: 32, status: 0x00 SUCCESS
12:09:55:282 APS-DATA.confirm request id: 32 -> confirmed, timeout 7884115
12:09:55:312 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:55:312 	asdu: 8f0005030115520affff2e2100f388e407008d150003b9120001eb
12:09:55:312 APS-DATA.indication request id: 32 -> finished
12:09:55:312 APS-DATA.request id: 32 erase from queue
12:09:55:313 APS-DATA.request id: 34, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:09:55:313 	asdu (length: 2): 9004
12:09:55:382 APS-DATA.confirm id: 34, status: 0x00 SUCCESS
12:09:55:382 APS-DATA.confirm request id: 34 -> confirmed, timeout 7884221
12:09:55:416 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:09:55:416 	asdu: 900005040115520affff2e210045dde307008d150085ee120001f9
12:09:55:416 APS-DATA.indication request id: 34 -> finished
12:09:55:416 APS-DATA.request id: 34 erase from queue
12:09:57:093 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:10:00:184 APS-DATA.request id: 36, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:00:184 	asdu (length: 2): 9100
12:10:00:252 APS-DATA.confirm id: 36, status: 0x00 SUCCESS
12:10:00:252 APS-DATA.confirm request id: 36 -> confirmed, timeout 7889092
12:10:00:286 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:00:286 	asdu: 910005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:00:286 APS-DATA.indication request id: 36 -> finished
12:10:00:286 APS-DATA.request id: 36 erase from queue
12:10:00:287 APS-DATA.request id: 38, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:00:287 	asdu (length: 2): 9201
12:10:00:352 APS-DATA.confirm id: 38, status: 0x00 SUCCESS
12:10:00:352 APS-DATA.confirm request id: 38 -> confirmed, timeout 7889195
12:10:00:386 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:00:386 	asdu: 920005010115520affff2e21002b490807008d150067e6120001f4
12:10:00:387 APS-DATA.indication request id: 38 -> finished
12:10:00:387 APS-DATA.request id: 38 erase from queue
12:10:00:387 APS-DATA.request id: 40, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:00:387 	asdu (length: 2): 9302
12:10:00:452 APS-DATA.confirm id: 40, status: 0x00 SUCCESS
12:10:00:452 APS-DATA.confirm request id: 40 -> confirmed, timeout 7889295
12:10:00:486 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:00:486 	asdu: 930005020115520affff2e21002ad85009008d1500181c120001ff
12:10:00:486 APS-DATA.indication request id: 40 -> finished
12:10:00:487 APS-DATA.request id: 40 erase from queue
12:10:00:487 APS-DATA.request id: 42, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:00:487 	asdu (length: 2): 9403
12:10:00:562 APS-DATA.confirm id: 42, status: 0x00 SUCCESS
12:10:00:562 APS-DATA.confirm request id: 42 -> confirmed, timeout 7889395
12:10:00:596 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:00:596 	asdu: 940005030115520affff2e2100f388e407008d150003b9120001eb
12:10:00:597 APS-DATA.indication request id: 42 -> finished
12:10:00:597 APS-DATA.request id: 42 erase from queue
12:10:00:597 APS-DATA.request id: 44, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:00:597 	asdu (length: 2): 9504
12:10:00:682 APS-DATA.confirm id: 44, status: 0x00 SUCCESS
12:10:00:682 APS-DATA.confirm request id: 44 -> confirmed, timeout 7889505
12:10:00:715 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:00:715 	asdu: 950005040115520affff2e210045dde307008d150085ee120001f9
12:10:00:716 APS-DATA.indication request id: 44 -> finished
12:10:00:716 APS-DATA.request id: 44 erase from queue
12:10:02:092 GW firmware version: 0x26690700
12:10:03:925 New websocket 10.15.4.240:51818 (state: 3) 
12:10:05:464 APS-DATA.request id: 46, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:05:464 	asdu (length: 2): 9600
12:10:05:532 APS-DATA.confirm id: 46, status: 0x00 SUCCESS
12:10:05:532 APS-DATA.confirm request id: 46 -> confirmed, timeout 7894373
12:10:05:566 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:05:566 	asdu: 960005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:05:566 APS-DATA.indication request id: 46 -> finished
12:10:05:566 APS-DATA.request id: 46 erase from queue
12:10:05:567 APS-DATA.request id: 48, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:05:567 	asdu (length: 2): 9701
12:10:05:632 APS-DATA.confirm id: 48, status: 0x00 SUCCESS
12:10:05:632 APS-DATA.confirm request id: 48 -> confirmed, timeout 7894475
12:10:05:666 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:05:666 	asdu: 970005010115520affff2e21002b490807008d150067e6120001f4
12:10:05:666 APS-DATA.indication request id: 48 -> finished
12:10:05:666 APS-DATA.request id: 48 erase from queue
12:10:05:667 APS-DATA.request id: 50, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:05:667 	asdu (length: 2): 9802
12:10:05:732 APS-DATA.confirm id: 50, status: 0x00 SUCCESS
12:10:05:732 APS-DATA.confirm request id: 50 -> confirmed, timeout 7894575
12:10:05:766 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:05:766 	asdu: 980005020115520affff2e21002ad85009008d1500181c120001ff
12:10:05:766 APS-DATA.indication request id: 50 -> finished
12:10:05:767 APS-DATA.request id: 50 erase from queue
12:10:05:767 APS-DATA.request id: 52, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:05:767 	asdu (length: 2): 9903
12:10:05:832 APS-DATA.confirm id: 52, status: 0x00 SUCCESS
12:10:05:832 APS-DATA.confirm request id: 52 -> confirmed, timeout 7894675
12:10:05:866 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:05:866 	asdu: 990005030115520affff2e2100f388e407008d150003b9120001eb
12:10:05:866 APS-DATA.indication request id: 52 -> finished
12:10:05:867 APS-DATA.request id: 52 erase from queue
12:10:05:867 APS-DATA.request id: 54, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:05:867 	asdu (length: 2): 9a04
12:10:05:942 APS-DATA.confirm id: 54, status: 0x00 SUCCESS
12:10:05:942 APS-DATA.confirm request id: 54 -> confirmed, timeout 7894775
12:10:05:982 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:05:982 	asdu: 9a0005040115520affff2e210045dde307008d150085ee120001f9
12:10:05:982 APS-DATA.indication request id: 54 -> finished
12:10:05:983 APS-DATA.request id: 54 erase from queue
12:10:07:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:10:10:745 APS-DATA.request id: 56, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:10:745 	asdu (length: 2): 9b00
12:10:10:812 APS-DATA.confirm id: 56, status: 0x00 SUCCESS
12:10:10:812 APS-DATA.confirm request id: 56 -> confirmed, timeout 7899653
12:10:10:852 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:10:852 	asdu: 9b0005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:10:852 APS-DATA.indication request id: 56 -> finished
12:10:10:852 APS-DATA.request id: 56 erase from queue
12:10:10:852 APS-DATA.request id: 58, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:10:853 	asdu (length: 2): 9c01
12:10:10:912 APS-DATA.confirm id: 58, status: 0x00 SUCCESS
12:10:10:912 APS-DATA.confirm request id: 58 -> confirmed, timeout 7899761
12:10:10:944 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:10:944 	asdu: 9c0005010115520affff2e21002b490807008d150067e6120001f4
12:10:10:944 APS-DATA.indication request id: 58 -> finished
12:10:10:944 APS-DATA.request id: 58 erase from queue
12:10:10:945 APS-DATA.request id: 60, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:10:945 	asdu (length: 2): 9d02
12:10:11:012 APS-DATA.confirm id: 60, status: 0x00 SUCCESS
12:10:11:012 APS-DATA.confirm request id: 60 -> confirmed, timeout 7899853
12:10:11:042 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:11:042 	asdu: 9d0005020115520affff2e21002ad85009008d1500181c120001ff
12:10:11:042 APS-DATA.indication request id: 60 -> finished
12:10:11:042 APS-DATA.request id: 60 erase from queue
12:10:11:043 APS-DATA.request id: 62, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:11:043 	asdu (length: 2): 9e03
12:10:11:102 APS-DATA.confirm id: 62, status: 0x00 SUCCESS
12:10:11:102 APS-DATA.confirm request id: 62 -> confirmed, timeout 7899951
12:10:11:132 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:11:132 	asdu: 9e0005030115520affff2e2100f388e407008d150003b9120001eb
12:10:11:133 APS-DATA.indication request id: 62 -> finished
12:10:11:133 APS-DATA.request id: 62 erase from queue
12:10:11:133 APS-DATA.request id: 64, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:11:133 	asdu (length: 2): 9f04
12:10:11:192 APS-DATA.confirm id: 64, status: 0x00 SUCCESS
12:10:11:192 APS-DATA.confirm request id: 64 -> confirmed, timeout 7900041
12:10:11:222 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:11:222 	asdu: 9f0005040115520affff2e210045dde307008d150085ee120001f9
12:10:11:222 APS-DATA.indication request id: 64 -> finished
12:10:11:223 APS-DATA.request id: 64 erase from queue
12:10:12:093 GW firmware version: 0x26690700
12:10:16:024 APS-DATA.request id: 66, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:16:024 	asdu (length: 2): a000
12:10:16:092 APS-DATA.confirm id: 66, status: 0x00 SUCCESS
12:10:16:092 APS-DATA.confirm request id: 66 -> confirmed, timeout 7904933
12:10:16:126 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:16:126 	asdu: a00005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:16:126 APS-DATA.indication request id: 66 -> finished
12:10:16:126 APS-DATA.request id: 66 erase from queue
12:10:16:127 APS-DATA.request id: 68, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:16:127 	asdu (length: 2): a101
12:10:16:192 APS-DATA.confirm id: 68, status: 0x00 SUCCESS
12:10:16:192 APS-DATA.confirm request id: 68 -> confirmed, timeout 7905035
12:10:16:226 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:16:226 	asdu: a10005010115520affff2e21002b490807008d150067e6120001f4
12:10:16:226 APS-DATA.indication request id: 68 -> finished
12:10:16:226 APS-DATA.request id: 68 erase from queue
12:10:16:227 APS-DATA.request id: 70, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:16:227 	asdu (length: 2): a202
12:10:16:292 APS-DATA.confirm id: 70, status: 0x00 SUCCESS
12:10:16:292 APS-DATA.confirm request id: 70 -> confirmed, timeout 7905135
12:10:16:326 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:16:326 	asdu: a20005020115520affff2e21002ad85009008d1500181c120001ff
12:10:16:326 APS-DATA.indication request id: 70 -> finished
12:10:16:327 APS-DATA.request id: 70 erase from queue
12:10:16:327 APS-DATA.request id: 72, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:16:327 	asdu (length: 2): a303
12:10:16:402 APS-DATA.confirm id: 72, status: 0x00 SUCCESS
12:10:16:402 APS-DATA.confirm request id: 72 -> confirmed, timeout 7905235
12:10:16:432 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:16:432 	asdu: a30005030115520affff2e2100f388e407008d150003b9120001eb
12:10:16:432 APS-DATA.indication request id: 72 -> finished
12:10:16:432 APS-DATA.request id: 72 erase from queue
12:10:16:433 APS-DATA.request id: 74, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:16:433 	asdu (length: 2): a404
12:10:16:502 APS-DATA.confirm id: 74, status: 0x00 SUCCESS
12:10:16:502 APS-DATA.confirm request id: 74 -> confirmed, timeout 7905341
12:10:16:542 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:16:542 	asdu: a40005040115520affff2e210045dde307008d150085ee120001f9
12:10:16:542 APS-DATA.indication request id: 74 -> finished
12:10:16:542 APS-DATA.request id: 74 erase from queue
12:10:17:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:10:20:593 Idle timer triggered
12:10:21:304 APS-DATA.request id: 76, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:21:304 	asdu (length: 2): a500
12:10:21:372 APS-DATA.confirm id: 76, status: 0x00 SUCCESS
12:10:21:372 APS-DATA.confirm request id: 76 -> confirmed, timeout 7910213
12:10:21:406 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:21:406 	asdu: a50005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:21:406 APS-DATA.indication request id: 76 -> finished
12:10:21:407 APS-DATA.request id: 76 erase from queue
12:10:21:407 APS-DATA.request id: 78, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:21:407 	asdu (length: 2): a601
12:10:21:472 APS-DATA.confirm id: 78, status: 0x00 SUCCESS
12:10:21:472 APS-DATA.confirm request id: 78 -> confirmed, timeout 7910315
12:10:21:511 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:21:512 	asdu: a60005010115520affff2e21002b490807008d150067e6120001f4
12:10:21:512 APS-DATA.indication request id: 78 -> finished
12:10:21:512 APS-DATA.request id: 78 erase from queue
12:10:21:512 APS-DATA.request id: 80, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:21:512 	asdu (length: 2): a702
12:10:21:572 APS-DATA.confirm id: 80, status: 0x00 SUCCESS
12:10:21:572 APS-DATA.confirm request id: 80 -> confirmed, timeout 7910420
12:10:21:602 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:21:602 	asdu: a70005020115520affff2e21002ad85009008d1500181c120001ff
12:10:21:602 APS-DATA.indication request id: 80 -> finished
12:10:21:603 APS-DATA.request id: 80 erase from queue
12:10:21:603 APS-DATA.request id: 82, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:21:603 	asdu (length: 2): a803
12:10:21:663 APS-DATA.confirm id: 82, status: 0x00 SUCCESS
12:10:21:663 APS-DATA.confirm request id: 82 -> confirmed, timeout 7910511
12:10:21:692 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:21:692 	asdu: a80005030115520affff2e2100f388e407008d150003b9120001eb
12:10:21:692 APS-DATA.indication request id: 82 -> finished
12:10:21:692 APS-DATA.request id: 82 erase from queue
12:10:21:693 APS-DATA.request id: 84, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:21:693 	asdu (length: 2): a904
12:10:21:762 APS-DATA.confirm id: 84, status: 0x00 SUCCESS
12:10:21:762 APS-DATA.confirm request id: 84 -> confirmed, timeout 7910601
12:10:21:792 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:21:792 	asdu: a90005040115520affff2e210045dde307008d150085ee120001f9
12:10:21:792 APS-DATA.indication request id: 84 -> finished
12:10:21:792 APS-DATA.request id: 84 erase from queue
12:10:22:092 GW firmware version: 0x26690700
12:10:26:585 APS-DATA.request id: 86, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:26:585 	asdu (length: 2): aa00
12:10:26:652 APS-DATA.confirm id: 86, status: 0x00 SUCCESS
12:10:26:652 APS-DATA.confirm request id: 86 -> confirmed, timeout 7915493
12:10:26:686 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:26:686 	asdu: aa0005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:26:686 APS-DATA.indication request id: 86 -> finished
12:10:26:687 APS-DATA.request id: 86 erase from queue
12:10:26:687 APS-DATA.request id: 88, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:26:687 	asdu (length: 2): ab01
12:10:26:742 APS-DATA.confirm id: 88, status: 0x00 SUCCESS
12:10:26:742 APS-DATA.confirm request id: 88 -> confirmed, timeout 7915595
12:10:26:782 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:26:782 	asdu: ab0005010115520affff2e21002b490807008d150067e6120001f4
12:10:26:782 APS-DATA.indication request id: 88 -> finished
12:10:26:782 APS-DATA.request id: 88 erase from queue
12:10:26:782 APS-DATA.request id: 90, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:26:783 	asdu (length: 2): ac02
12:10:26:842 APS-DATA.confirm id: 90, status: 0x00 SUCCESS
12:10:26:842 APS-DATA.confirm request id: 90 -> confirmed, timeout 7915691
12:10:26:872 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:26:872 	asdu: ac0005020115520affff2e21002ad85009008d1500181c120001ff
12:10:26:872 APS-DATA.indication request id: 90 -> finished
12:10:26:872 APS-DATA.request id: 90 erase from queue
12:10:26:873 APS-DATA.request id: 92, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:26:873 	asdu (length: 2): ad03
12:10:26:942 APS-DATA.confirm id: 92, status: 0x00 SUCCESS
12:10:26:942 APS-DATA.confirm request id: 92 -> confirmed, timeout 7915781
12:10:26:972 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:26:972 	asdu: ad0005030115520affff2e2100f388e407008d150003b9120001eb
12:10:26:973 APS-DATA.indication request id: 92 -> finished
12:10:26:973 APS-DATA.request id: 92 erase from queue
12:10:26:973 APS-DATA.request id: 94, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:26:973 	asdu (length: 2): ae04
12:10:27:032 APS-DATA.confirm id: 94, status: 0x00 SUCCESS
12:10:27:032 APS-DATA.confirm request id: 94 -> confirmed, timeout 7915881
12:10:27:062 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:27:062 	asdu: ae0005040115520affff2e210045dde307008d150085ee120001f9
12:10:27:062 APS-DATA.indication request id: 94 -> finished
12:10:27:062 APS-DATA.request id: 94 erase from queue
12:10:27:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:10:31:864 APS-DATA.request id: 96, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:31:864 	asdu (length: 2): af00
12:10:31:932 APS-DATA.confirm id: 96, status: 0x00 SUCCESS
12:10:31:932 APS-DATA.confirm request id: 96 -> confirmed, timeout 7920772
12:10:31:972 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:31:972 	asdu: af0005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:31:972 APS-DATA.indication request id: 96 -> finished
12:10:31:972 APS-DATA.request id: 96 erase from queue
12:10:31:973 APS-DATA.request id: 98, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:31:973 	asdu (length: 2): b001
12:10:32:032 APS-DATA.confirm id: 98, status: 0x00 SUCCESS
12:10:32:032 APS-DATA.confirm request id: 98 -> confirmed, timeout 7920881
12:10:32:062 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:32:062 	asdu: b00005010115520affff2e21002b490807008d150067e6120001f4
12:10:32:062 APS-DATA.indication request id: 98 -> finished
12:10:32:062 APS-DATA.request id: 98 erase from queue
12:10:32:063 APS-DATA.request id: 100, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:32:063 	asdu (length: 2): b102
12:10:32:122 APS-DATA.confirm id: 100, status: 0x00 SUCCESS
12:10:32:122 APS-DATA.confirm request id: 100 -> confirmed, timeout 7920971
12:10:32:152 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:32:152 	asdu: b10005020115520affff2e21002ad85009008d1500181c120001ff
12:10:32:152 APS-DATA.indication request id: 100 -> finished
12:10:32:152 APS-DATA.request id: 100 erase from queue
12:10:32:153 APS-DATA.request id: 102, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:32:153 	asdu (length: 2): b203
12:10:32:182 GW firmware version: 0x26690700
12:10:32:212 APS-DATA.confirm id: 102, status: 0x00 SUCCESS
12:10:32:213 APS-DATA.confirm request id: 102 -> confirmed, timeout 7921061
12:10:32:242 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:32:242 	asdu: b20005030115520affff2e2100f388e407008d150003b9120001eb
12:10:32:242 APS-DATA.indication request id: 102 -> finished
12:10:32:242 APS-DATA.request id: 102 erase from queue
12:10:32:242 APS-DATA.request id: 104, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:32:243 	asdu (length: 2): b304
12:10:32:302 APS-DATA.confirm id: 104, status: 0x00 SUCCESS
12:10:32:302 APS-DATA.confirm request id: 104 -> confirmed, timeout 7921151
12:10:32:332 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:32:332 	asdu: b30005040115520affff2e210045dde307008d150085ee120001f9
12:10:32:332 APS-DATA.indication request id: 104 -> finished
12:10:32:332 APS-DATA.request id: 104 erase from queue
12:10:37:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:10:37:144 APS-DATA.request id: 106, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:37:144 	asdu (length: 2): b400
12:10:37:223 APS-DATA.confirm id: 106, status: 0x00 SUCCESS
12:10:37:223 APS-DATA.confirm request id: 106 -> confirmed, timeout 7926053
12:10:37:262 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:37:262 	asdu: b40005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:37:262 APS-DATA.indication request id: 106 -> finished
12:10:37:262 APS-DATA.request id: 106 erase from queue
12:10:37:262 APS-DATA.request id: 108, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:37:262 	asdu (length: 2): b501
12:10:37:322 APS-DATA.confirm id: 108, status: 0x00 SUCCESS
12:10:37:322 APS-DATA.confirm request id: 108 -> confirmed, timeout 7926171
12:10:37:352 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:37:352 	asdu: b50005010115520affff2e21002b490807008d150067e6120001f4
12:10:37:352 APS-DATA.indication request id: 108 -> finished
12:10:37:352 APS-DATA.request id: 108 erase from queue
12:10:37:353 APS-DATA.request id: 110, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:37:353 	asdu (length: 2): b602
12:10:37:412 APS-DATA.confirm id: 110, status: 0x00 SUCCESS
12:10:37:412 APS-DATA.confirm request id: 110 -> confirmed, timeout 7926261
12:10:37:442 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:37:442 	asdu: b60005020115520affff2e21002ad85009008d1500181c120001ff
12:10:37:442 APS-DATA.indication request id: 110 -> finished
12:10:37:442 APS-DATA.request id: 110 erase from queue
12:10:37:442 APS-DATA.request id: 112, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:37:443 	asdu (length: 2): b703
12:10:37:502 APS-DATA.confirm id: 112, status: 0x00 SUCCESS
12:10:37:502 APS-DATA.confirm request id: 112 -> confirmed, timeout 7926351
12:10:37:532 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:37:532 	asdu: b70005030115520affff2e2100f388e407008d150003b9120001eb
12:10:37:532 APS-DATA.indication request id: 112 -> finished
12:10:37:532 APS-DATA.request id: 112 erase from queue
12:10:37:533 APS-DATA.request id: 114, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:37:533 	asdu (length: 2): b804
12:10:37:592 APS-DATA.confirm id: 114, status: 0x00 SUCCESS
12:10:37:592 APS-DATA.confirm request id: 114 -> confirmed, timeout 7926441
12:10:37:623 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:37:623 	asdu: b80005040115520affff2e210045dde307008d150085ee120001f9
12:10:37:623 APS-DATA.indication request id: 114 -> finished
12:10:37:623 APS-DATA.request id: 114 erase from queue
12:10:42:092 GW firmware version: 0x26690700
12:10:42:424 APS-DATA.request id: 116, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:42:424 	asdu (length: 2): b900
12:10:42:482 APS-DATA.confirm id: 116, status: 0x00 SUCCESS
12:10:42:482 APS-DATA.confirm request id: 116 -> confirmed, timeout 7931332
12:10:42:516 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:42:516 	asdu: b90005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:42:516 APS-DATA.indication request id: 116 -> finished
12:10:42:516 APS-DATA.request id: 116 erase from queue
12:10:42:517 APS-DATA.request id: 118, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:42:517 	asdu (length: 2): ba01
12:10:42:582 APS-DATA.confirm id: 118, status: 0x00 SUCCESS
12:10:42:582 APS-DATA.confirm request id: 118 -> confirmed, timeout 7931425
12:10:42:627 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:42:627 	asdu: ba0005010115520affff2e21002b490807008d150067e6120001f4
12:10:42:627 APS-DATA.indication request id: 118 -> finished
12:10:42:627 APS-DATA.request id: 118 erase from queue
12:10:42:627 APS-DATA.request id: 120, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:42:627 	asdu (length: 2): bb02
12:10:42:692 APS-DATA.confirm id: 120, status: 0x00 SUCCESS
12:10:42:692 APS-DATA.confirm request id: 120 -> confirmed, timeout 7931536
12:10:42:722 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:42:722 	asdu: bb0005020115520affff2e21002ad85009008d1500181c120001ff
12:10:42:722 APS-DATA.indication request id: 120 -> finished
12:10:42:722 APS-DATA.request id: 120 erase from queue
12:10:42:723 APS-DATA.request id: 122, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:42:723 	asdu (length: 2): bc03
12:10:42:782 APS-DATA.confirm id: 122, status: 0x00 SUCCESS
12:10:42:782 APS-DATA.confirm request id: 122 -> confirmed, timeout 7931631
12:10:42:812 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:42:812 	asdu: bc0005030115520affff2e2100f388e407008d150003b9120001eb
12:10:42:812 APS-DATA.indication request id: 122 -> finished
12:10:42:812 APS-DATA.request id: 122 erase from queue
12:10:42:812 APS-DATA.request id: 124, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:42:813 	asdu (length: 2): bd04
12:10:42:872 APS-DATA.confirm id: 124, status: 0x00 SUCCESS
12:10:42:872 APS-DATA.confirm request id: 124 -> confirmed, timeout 7931721
12:10:42:902 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:42:902 	asdu: bd0005040115520affff2e210045dde307008d150085ee120001f9
12:10:42:902 APS-DATA.indication request id: 124 -> finished
12:10:42:902 APS-DATA.request id: 124 erase from queue
12:10:47:092 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:10:47:704 APS-DATA.request id: 126, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:47:704 	asdu (length: 2): be00
12:10:47:772 APS-DATA.confirm id: 126, status: 0x00 SUCCESS
12:10:47:772 APS-DATA.confirm request id: 126 -> confirmed, timeout 7936612
12:10:47:806 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:47:806 	asdu: be0005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:47:806 APS-DATA.indication request id: 126 -> finished
12:10:47:806 APS-DATA.request id: 126 erase from queue
12:10:47:807 APS-DATA.request id: 128, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:47:807 	asdu (length: 2): bf01
12:10:47:872 APS-DATA.confirm id: 128, status: 0x00 SUCCESS
12:10:47:872 APS-DATA.confirm request id: 128 -> confirmed, timeout 7936715
12:10:47:906 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:47:906 	asdu: bf0005010115520affff2e21002b490807008d150067e6120001f4
12:10:47:906 APS-DATA.indication request id: 128 -> finished
12:10:47:906 APS-DATA.request id: 128 erase from queue
12:10:47:907 APS-DATA.request id: 130, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:47:907 	asdu (length: 2): c002
12:10:47:972 APS-DATA.confirm id: 130, status: 0x00 SUCCESS
12:10:47:972 APS-DATA.confirm request id: 130 -> confirmed, timeout 7936815
12:10:47:006 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:47:006 	asdu: c00005020115520affff2e21002ad85009008d1500181c120001ff
12:10:47:006 APS-DATA.indication request id: 130 -> finished
12:10:47:006 APS-DATA.request id: 130 erase from queue
12:10:47:007 APS-DATA.request id: 132, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:47:007 	asdu (length: 2): c103
12:10:48:082 APS-DATA.confirm id: 132, status: 0x00 SUCCESS
12:10:48:082 APS-DATA.confirm request id: 132 -> confirmed, timeout 7936915
12:10:48:112 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:48:112 	asdu: c10005030115520affff2e2100f388e407008d150003b9120001eb
12:10:48:112 APS-DATA.indication request id: 132 -> finished
12:10:48:112 APS-DATA.request id: 132 erase from queue
12:10:48:113 APS-DATA.request id: 134, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:48:113 	asdu (length: 2): c204
12:10:48:182 APS-DATA.confirm id: 134, status: 0x00 SUCCESS
12:10:48:182 APS-DATA.confirm request id: 134 -> confirmed, timeout 7937021
12:10:48:216 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:48:216 	asdu: c20005040115520affff2e210045dde307008d150085ee120001f9
12:10:48:216 APS-DATA.indication request id: 134 -> finished
12:10:48:216 APS-DATA.request id: 134 erase from queue
12:10:50:592 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1
12:10:50:593 Idle timer triggered
12:10:52:093 GW firmware version: 0x26690700
12:10:52:984 APS-DATA.request id: 136, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:52:984 	asdu (length: 2): c300
12:10:53:052 APS-DATA.confirm id: 136, status: 0x00 SUCCESS
12:10:53:052 APS-DATA.confirm request id: 136 -> confirmed, timeout 7941893
12:10:53:086 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:53:086 	asdu: c30005000115520affff2e210073f0e207008d15008fbe120001fc
12:10:53:086 APS-DATA.indication request id: 136 -> finished
12:10:53:086 APS-DATA.request id: 136 erase from queue
12:10:53:086 APS-DATA.request id: 138, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:53:087 	asdu (length: 2): c401
12:10:53:152 APS-DATA.confirm id: 138, status: 0x00 SUCCESS
12:10:53:152 APS-DATA.confirm request id: 138 -> confirmed, timeout 7941995
12:10:53:186 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:53:186 	asdu: c40005010115520affff2e21002b490807008d150067e6120001f4
12:10:53:187 APS-DATA.indication request id: 138 -> finished
12:10:53:187 APS-DATA.request id: 138 erase from queue
12:10:53:187 APS-DATA.request id: 140, addrmode: 0x03, addr: 0x00212effff0a5215, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:10:53:187 	asdu (length: 2): c502
12:10:53:252 APS-DATA.confirm id: 140, status: 0x00 SUCCESS
12:10:53:252 APS-DATA.confirm request id: 140 -> confirmed, timeout 7942095
12:10:53:286 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:10:53:286 	asdu: c50005020115520affff2e21002ad85009008d1500181c120001ff
12:10:53:286 APS-DATA.indication request id: 140 -> finished
12:10:53:286 APS-DATA.request id: 140 erase from queue

OMR · August 30, 2023, 8:20pm

Cannot see anything suspicious.
Try over at https://forum.phoscon.de/ ?

kaloschke · October 27, 2023, 2:08pm

Hello,
I have exactly the same problem with Openhab 4.0.3. Openhab and Deconz are each running in a container. Everything works fine so far except for the mentioned problem.
Is there any new knowledge about this?

Opa · January 6, 2024, 5:14pm

Hello,
I haven’t done anything with Openhab for a long time now and wanted to start again. Unfortunately, I also ran into exactly this problem.
I have already used all the tips from this post and from the following post in phoscon forum, unfortunately without success.
Either I have overlooked something important or the solution is not included?!

I did a fresh installation of openHAB 4.1.0 with the latest stable openHABian version (openHABian v1.8b).
Setup information
Platform: Raspberry Pi 4 Model B Rev 1.2
openHAB 4.1.0
deCONZ Binding 4.1.0

Conbee II
Firmware 26780700
Gateway Version 2.24.2

OpenHAB web frontend is available on port 8080 and 8443 without issues.
Phoscon web application is available on port 8081 without issues.

OpenHAB events.log (deCONZ binding on trace level)

2024-01-06 17:40:10.549 [TRACE] [nternal.netutils.WebSocketConnection] - Websocket$1704559080514-17 closed connection: 1006 / Disconnected
2024-01-06 17:40:10.551 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'deconz:deconz:00212E048610' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 120s. Websocket seems to be dead.
2024-01-06 17:40:20.578 [DEBUG] [nternal.netutils.WebSocketConnection] - Trying to connect Websocket$1704559210565-18 to ws://192.168.178.80:443
2024-01-06 17:40:20.591 [DEBUG] [nternal.netutils.WebSocketConnection] - Websocket$1704559210565-18 successfully connected to /192.168.178.80: 19828317
2024-01-06 17:40:20.596 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'deconz:deconz:00212E048610' changed from OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 120s. Websocket seems to be dead. to ONLINE

Does anyone else currently still have the problem or have you all been able to solve the problem for yourselves?
Thanks and regards!

OMR · January 6, 2024, 7:47pm

I use debian package install of both openhab and deconz on Ubuntu.
Running deconz on port 80 and openhab on port 8080.
No such problems.

BirkADH · January 7, 2024, 9:22pm

I have the same problems.
My configuration is
Synology 920+
OpenHAB 4.1. as a docker container

Conbee2
Gateway version 2.25.0
Firmware 26780700
also on the Synology and as a Docker container.

Interesting is that if I use my old configuration then I don’t get a websocket timeout
Old config
Platform: Raspberry Pi 4
openHAB 4.0.4
and
Conbee2
Gateway version 2.25.0
Firmware 26780700
on the Synology and as a Docker container.

It is also interesting that if one of my sensors happens to send an update for the Conbee2, the timeout only occurs 120 seconds after the update.

2024-01-07 21:41:39.643 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'deconz:deconz:000000000000' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 120s. Websocket seems to be dead.
2024-01-07 21:41:49.651 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'deconz:deconz:000000000000' changed from OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 120s. Websocket seems to be dead. to ONLINE
2024-01-07 21:43:49.651 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'deconz:deconz:000000000000' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 120s. Websocket seems to be dead.
2024-01-07 21:45:35.862 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Luftfeuchtigkeit_Kind_Luftfeuchtigkeit' changed from 0.557 to 0.55800000000000004
2024-01-07 21:47:35.859 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'deconz:deconz:000000000000' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 120s. Websocket seems to be dead.

1 line, the timeout
2 line, the reconnect
3 line, exactly 2 minutes later, the timeout again.
4 line update of a sensor 1min and 46 seconds after the last timeout
5 line exactly 2 minutes after the update, another timeout.

should mean that if there was an update every 2 minutes we would have no more timeouts . But that can’t be the solution…

Edit:
Data is transmitted from the sensors and also displayed in OpenHAB.

AlexOH · February 7, 2024, 4:50pm

Did anybody find a solution for this? I have exactly the same problem. I’ve been using OH for a couple of years now, with the Conbee II for my Zigbee devices (switches and sensors). First running on OH 2 and then on OH3. Without many problems so far. After a firmware upgrade of the Conbee II a few weeks ago, I kept loosing connection to some of the devices (only to switches, sensors are all ok).
As I wanted to migrate to OH4 anyway I started a clean install on a new RPI4 and also bought a Conbee III for this. I installed the stick and binding etc and configured some things and items to test this afternoon (I use files to configure things and items btw). Now I can see the exact same behaviour as mentioned in this thread. Every 2 minutes the deconz server goes offline (Watchdog timed out after 120s. Websocket seems to be dead). After approx. 10 seconds it comes online again… Any help would be appreciated.

Oidinga · February 12, 2024, 6:51pm

Hi everyone,
same issue here. It happens roughly every 5 minutes.

openHAB 4.1.0
raspbian
Java Runtime 17.0.9
ConBee II, Gateway Version 2.24.2, Firmware 26720700

2024-02-12 19:41:05.707 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'deconz:deconz:000000000000' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 200s. Websocket seems to be dead.
2024-02-12 19:41:15.730 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'deconz:deconz:000000000000' changed from OFFLINE (COMMUNICATION_ERROR): Watchdog timed out after 200s. Websocket seems to be dead. to ONLINE

openhabian@openhabian:~ $ sudo systemctl status deconz
● deconz.service - deCONZ: ZigBee gateway -- REST API
     Loaded: loaded (/lib/systemd/system/deconz.service; enabled; vendor preset: enabled)
     Active: active (running) since Sat 2024-01-13 15:41:45 CET; 4 weeks 2 days ago
   Main PID: 352 (deCONZ)
      Tasks: 6 (limit: 4531)
        CPU: 11h 58min 55.407s
     CGroup: /system.slice/deconz.service
             └─352 /usr/bin/deCONZ -platform minimal --http-port=80

Warning: journal has been rotated since unit was started, output may be incomplete.

Any help or hint appreciated!

Wolfgang_S · February 12, 2024, 7:16pm

Don’t know if this will help but what is the output of

netstat -tulpn |egrep -i "deconz|80"

This command should show ports that are used by the deconz application and any port/application that is related to 80.

Oidinga · February 12, 2024, 8:08pm

Hi Wolfgang,

this is the output:

openhabian@openhabian:~ $ netstat -tulpn |egrep -i "deconz|80"
(Not all processes could be identified, non-owned process info
 will not be shown, you would have to be root to see it all.)
tcp        0      0 0.0.0.0:80              0.0.0.0:*               LISTEN      -
tcp6       0      0 :::8080                 :::*                    LISTEN      -
udp6       0      0 192.168.178.150:53980   :::*                                -
udp6       0      0 :::38049                :::*                                -

Thanks for the help!

Wolfgang_S · February 12, 2024, 8:48pm

Can you try the same command with sudo in front of it.
I forgot to add it. This also should show the process names that run on the related ports.

sudo netstat -tulpn |egrep -i "deconz|80"

Oidinga · February 12, 2024, 8:53pm

Hi Wolfgang, I could have also thought of that… here is the new snippet

openhabian@openhabian:~ $ sudo netstat -tulpn |egrep -i "deconz|80"
tcp        0      0 0.0.0.0:9001            0.0.0.0:*               LISTEN      805/node
tcp        0      0 0.0.0.0:80              0.0.0.0:*               LISTEN      352/deCONZ
tcp        0      0 0.0.0.0:443             0.0.0.0:*               LISTEN      352/deCONZ
tcp6       0      0 :::8101                 :::*                    LISTEN      804/java
tcp6       0      0 :::8080                 :::*                    LISTEN      804/java
tcp6       0      0 :::5007                 :::*                    LISTEN      804/java
tcp6       0      0 127.0.0.1:37499         :::*                    LISTEN      804/java
tcp6       0      0 :::8443                 :::*                    LISTEN      804/java
udp        0      0 0.0.0.0:1900            0.0.0.0:*                           352/deCONZ
udp        0      0 192.168.178.255:137     0.0.0.0:*                           800/nmbd
udp        0      0 192.168.178.150:137     0.0.0.0:*                           800/nmbd
udp        0      0 0.0.0.0:137             0.0.0.0:*                           800/nmbd
udp        0      0 192.168.178.255:138     0.0.0.0:*                           800/nmbd
udp        0      0 192.168.178.150:138     0.0.0.0:*                           800/nmbd
udp        0      0 0.0.0.0:138             0.0.0.0:*                           800/nmbd
udp6       0      0 :::1900                 :::*                                804/java
udp6       0      0 :::67                   :::*                                804/java
udp6       0      0 :::47254                :::*                                804/java
udp6       0      0 192.168.178.150:53980   :::*                                804/java
udp6       0      0 :::5353                 :::*                                804/java
udp6       0      0 :::56702                :::*                                804/java
udp6       0      0 :::34202                :::*                                804/java

Wolfgang_S · February 12, 2024, 9:38pm

Thanks, that - as far as I can see - looks similar to my environment.
Yours uses port 80 while I am using port 8090 as nginx runs on port 80 here.
Using 9443 instead of 443 here.
But that should be ok.

Oidinga · February 13, 2024, 11:20am

Thanks Wolfgang for checking. Any other hint is appreciated

Oidinga · February 18, 2024, 8:22pm

In case it is helpful to anyone else: As a “workaround” to get rid of all the log messages, I set the timeout to 6 minutes in the deconz settings. So far the function of all my sensors remain and the annoying status messages are gone.