Insteon Binding (Beta) [3.3.0;3.5.0)

jeshab · September 2, 2022, 3:58am

This is a rework of the Insteon binding adding some much needed improvements for OH3.

Apart from simplifying the user experience by retrieving all the configuration directly from the device when possible, and improving the way the Insteon things are configured in MainUI, here is an exhaustive list of the changes:

Introduced device configuration automated determination
Converted mode-based number items to string type with descriptive states
Added number items uom support
Added scenes and X10 device things
Added distinct bridge things for supported Hub/PLM devices
Added button event trigger channels
Added device products configuration layer
Added device link database support
Added device cache storage
Added device operating flags controls
Added modem configuration flags controls
Added related devices synchronization feature
Added ability to link a device to the modem
Improved console commands
Improved discovery service
Improved thing status

For more details, see the updated documentation.

It is important to note that this is a breaking change. This means that users that are currently using the official binding will be required to reconfigure their Insteon setup. However, that process should be much easier with the new improvements.

To install this beta version, you must first uninstall the official Insteon binding.
If you are deploying the jar file, you need to install the transport serial feature via the console:

feature:install openhab-transport-serial

Changelog

Version 20220910

Prevent offline not responding thing status for battery-operated devices
Fix siren device integration

Version 20220901

Initial Release

Resources

Latest release kar file: here
Latest release jar file: here
Source code: here
Pull request: here

Burzin_Sumariwalla · September 7, 2022, 12:53pm

Hi Jeremy,

As so happens I’m in the process of recovering from a broken upgrade and a migration to a new Pi, so I’ll give your binding a spin tonight. What are the advantages of your binding over the official one, and what tests would you like to see run?

Regards,
Burzin

jeshab · September 7, 2022, 10:55pm

The binding improves the overall user experience taking advantage of what the latest OH framework has to offer, such as triggered events.

It also reduces the amount of configuration needed to control devices as it now downloads each device product data and link database to automatically determine the device type and the related devices/groups.

Optionally, the state of related devices can be synchronized based on their link databases when sending commands removing the need to use rules to accomplish that.

Ideally for this testing, you would disable/remove your old bridge/thing configuration and add a new bridge matching your modem type via MainUI preferrably. Once the modem database is downloaded, all your linked devices should be discovered automatically with the corresponding product name. For battery-operated devices, you would need to wake them up or wait until the next heartbeat for the actual product name to show in your inbox. You can also just directly add such device and it will be automatically updated the next time it is awake.

When adding a new thing, the associated device link database will get downloaded the first time within the poll interval cycle, or when it is awake (battery-operated). That information along other data points are cached to speed up the process on subsequent server restarts.

As far as testing channels, a lot of the underlying code has been updated. So far, I was able to test successfully with the below devices. I would need help in testing other modem types, devices and also larger setup if possible. I added some untested code to download the link database from older I1 devices using the older peek/poke method. If anyone has a Smartenit EZIO device to test with, that would be great.

Insteon 2245-222 Hub (Bridge)
Insteon 2456S3 ApplianceLinc
Insteon 2475F FanLinc
Insteon 2845-222 Hidden Door Sensor
Insteon 2334-232 Keypad Dimmer 6-Button
Insteon 2334-222 Keypad Dimmer 8-Button
Insteon 2852-222 Leak Sensor
Insteon 2843-222 Open/Close Sensor
Insteon 2477D SwitchLinc Dimmer

nh905 · September 10, 2022, 9:08pm

@jeshab I have a few switches/dimmers, appliance/dimmer modules, keypads, motion detectors, and leak sensors. Some of them were configured through the Main UI and are being used in Rules. Will the new binding continue to use the old definitions or update them based on the modem/device databases?

jeshab · September 10, 2022, 10:16pm

If by old definitions, you are referring to the thing/item configuration, the new binding is not backward compatible as a lot of the channels have changed in name and also type.

However, the configuration with the new binding should be much easier as it is using modem/device databases to determine most of the configuration automatically.

LORDUDE · March 31, 2023, 3:42pm

Is the plan to replace the current Insteon binding with this one? Can I run both bindings simultaneously? one using the hub and the other using the serial PLM? I’m planning to move away from Hiub since Insteon insist in charging just to use the app.

jeshab · March 31, 2023, 8:49pm

I am currently working on a new update for OH4.0. My hope would be that this binding would replace the current official one in the upcoming version.

You shouldn’t need to run both concurrently. This binding supports connecting to multiple modems at the same time. You should be able to add two bridges and the associated devices should be discovered. If not, let me know as I would be interested in troubleshooting this use case.

LORDUDE · April 17, 2023, 8:15am

Hello, I found sometime to port my configuration to the new binding below are my observations.

I works fine with two bridges a PLM and a HUB2 - I have most of my devices in the HUB but planning to move everything to the PLM since I refuse to pay insteon a subscription just to link devices
it took forever to update all my devices - about ~50 - it is still going - I hope is does not take this long on every openhab relaod
I did not wake up the motion detector or leak detectors I will wait a day to see if they come online
the openhab console is nice, I see you can read devices database, it would be nice if it would allow to remove deadlink from devices - I have very old devices (dead PLM/HUBs) with old link that i know slow down the insteon communication
I have several KeyPad - most configure for 6 bottoms and one configure for 8 bottoms - the 6 button ones show keypadButtonX(A-D) and buttonX(A-D) while the 8 button keypadButtonX(B-G) but
only buttonX(A-D) - is this intentional?

Overall, it seems to be working fine - I will do more testing and post any questions here -

jeshab · April 17, 2023, 2:23pm

Yes there is caching done after the very first successful device poll. So it is normal that it took some time when first connecting the binding to your PLM and Hub devices.

These should be polled within 24 hours after the binding receives the heartbeat broadcast message from these devices.

Yes. This is mimicking how Insteon named the buttons on these devices. The 6 button keypad has two main buttons “ON” and “OFF” that are controlled through the dimmer or switch channels depending on your device type and 4 scene buttons A-D with their separate channels. On the other hand the 8 button keypad has one main button that is controlled through the dimmer or switch channels and 7 scene buttons B-H with their separate channels.

LORDUDE · April 17, 2023, 5:00pm

Jeremy, 6 hours later I still have several device that are still config pending (yellow) and few are are offline (red). I never has this issue with the previous binding. I tried disabling the device and enabling back, this worked for some but not for the others, they just stay config pending. I might have to restore from a backup because i need my system functional.

Binding seems to be struggling with most of the keypads and outlets (single outlet type) the other devices still config pending are the battery devices.

Another observation is I have a KeyPadLink Timer that has 8 buttons but it show up with a configuration of 6. The other 8 bottom Keypad is still waiting for configuration.

There are 38 devices configured:
adrianlsw: address=1B.8E.E4 channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=ONLINE
alexrsw: address=23.EA.B1 channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=ONLINE
backyardsw: address=15.97.5A status=UNKNOWN
basementrsw: address=14.6D.A6 channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=ONLINE
bathfansw: address=17.96.4A channels=dimmer,buttonA,buttonB,buttonC,buttonD,eventButtonMain,eventButtonA,eventButtonB,eventButtonC,eventButtonD,beep,ledBrightness,rampRate,onLevel,toggleModeButtonA,toggleModeButtonB,toggleModeButtonC,toggleModeButtonD,programLock,ledTraffic,resumeDim,buttonConfig,buttonBeep,lastHeardFrom status=UNKNOWN
decklghtkp: address=13.C3.75 channels=switch,buttonA,buttonB,buttonC,buttonD,eventButtonMain,eventButtonA,eventButtonB,eventButtonC,eventButtonD,beep,ledBrightness,toggleModeButtonA,toggleModeButtonB,toggleModeButtonC,toggleModeButtonD,programLock,ledTraffic,buttonConfig,buttonBeep,lastHeardFrom status=ONLINE
dinningdsw: address=42.BD.9F channels=dimmer,eventButton,beep,ledBrightness,rampRate,onLevel,programLock,ledTraffic,resumeDim,buttonBeep,lastHeardFrom status=ONLINE
familytvmsw: address=14.66.EA channels=switch,eventButton,beep,programLock,ledTraffic,ledOnOff,loadSense,lastHeardFrom status=ONLINE
fencelsw: address=15.97.4D channels=switch,eventButton,beep,programLock,ledTraffic,ledOnOff,loadSense,lastHeardFrom status=UNKNOWN
fountainsw: address=14.69.DF channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=UNKNOWN
frontlghtkp: address=24.F0.F1 channels=switch,buttonA,buttonB,buttonC,buttonD,eventButtonMain,eventButtonA,eventButtonB,eventButtonC,eventButtonD,beep,ledBrightness,toggleModeButtonA,toggleModeButtonB,toggleModeButtonC,toggleModeButtonD,programLock,ledTraffic,buttonConfig,buttonBeep,lastHeardFrom status=ONLINE
garage1: address=15.BC.41 channels=switch,contact,momentaryDuration,programLock,ledTraffic,relaySensorFollow,relayMode,lastHeardFrom status=ONLINE
garage2: address=1C.0C.FD channels=switch,contact,momentaryDuration,programLock,ledTraffic,relaySensorFollow,relayMode,lastHeardFrom status=ONLINE
gymroomsw: address=33.F6.43 channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=ONLINE
hsideoutlet: address=57.85.C7 channels=outletTop,outletBottom,eventButtonTop,eventButtonBottom,beep,ledBrightness,programLock,ledTraffic,loadSenseTop,loadSenseBottom,buttonBeep,lastHeardFrom status=ONLINE
huttublghtkp: address=15.63.AF channels=switch,buttonA,buttonB,buttonC,buttonD,eventButtonMain,eventButtonA,eventButtonB,eventButtonC,eventButtonD,beep,ledBrightness,toggleModeButtonA,toggleModeButtonB,toggleModeButtonC,toggleModeButtonD,programLock,ledTraffic,buttonConfig,buttonBeep,lastHeardFrom status=UNKNOWN
islanddsw: address=25.4B.F4 channels=dimmer,eventButton,beep,ledBrightness,rampRate,onLevel,programLock,ledTraffic,resumeDim,buttonBeep,lastHeardFrom status=ONLINE
kitchendsw: address=25.48.24 channels=dimmer,eventButton,beep,ledBrightness,rampRate,onLevel,programLock,ledTraffic,resumeDim,buttonBeep,lastHeardFrom status=ONLINE
ksinkdsw: address=1B.3D.90 channels=dimmer,eventButton,beep,ledBrightness,rampRate,onLevel,programLock,ledTraffic,resumeDim,buttonBeep,lastHeardFrom status=ONLINE
lamplnk1429: address=14.29.45 channels=dimmer,eventButton,beep,ledBrightness,rampRate,onLevel,programLock,ledTraffic,resumeDim,loadSense,lastHeardFrom status=ONLINE
lamplnk142B: address=14.2B.53 channels=dimmer,eventButton,beep,ledBrightness,rampRate,onLevel,programLock,ledTraffic,resumeDim,loadSense,lastHeardFrom status=ONLINE
lamplnk2EB4: address=2E.B4.20 channels=dimmer,eventButton,beep,ledBrightness,rampRate,onLevel,programLock,ledTraffic,resumeDim,loadSense,lastHeardFrom status=ONLINE
lamplnk2EB8: address=2E.B8.A3 status=UNKNOWN
lamplnk2EB8D0: address=2E.B8.D0 channels=dimmer,eventButton,beep,ledBrightness,rampRate,onLevel,programLock,ledTraffic,resumeDim,loadSense,lastHeardFrom status=ONLINE
leaksen1: address=23.31.AC channels=leak,ledBrightness,programLock,stayAwake,lastHeardFrom status=UNKNOWN
leaksen2: address=23.2C.9F status=UNKNOWN
mancavelsw: address=34.75.1C channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=ONLINE
mancaveoutlet: address=41.8D.E2 channels=outletTop,outletBottom,eventButtonTop,eventButtonBottom,beep,ledBrightness,programLock,ledTraffic,loadSenseTop,loadSenseBottom,buttonBeep,lastHeardFrom status=ONLINE
mancavetvsw: address=1B.68.10 channels=switch,eventButton,beep,programLock,ledTraffic,ledOnOff,loadSense,lastHeardFrom status=ONLINE
masterkp: address=15.64.7D channels=switch,buttonA,buttonB,buttonC,buttonD,eventButtonMain,eventButtonA,eventButtonB,eventButtonC,eventButtonD,beep,ledBrightness,toggleModeButtonA,toggleModeButtonB,toggleModeButtonC,toggleModeButtonD,programLock,ledTraffic,buttonConfig,buttonBeep,lastHeardFrom status=UNKNOWN
motionsen1: address=23.17.97 channels=motion,daylight,lowBattery,batteryLevel,lightLevel,programLock,ledOnOff,stayAwake,lastHeardFrom status=UNKNOWN
nookdsw: address=25.45.2D channels=dimmer,eventButton,beep,ledBrightness,rampRate,onLevel,programLock,ledTraffic,resumeDim,buttonBeep,lastHeardFrom status=ONLINE
officelsw: address=1B.F9.38 channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=ONLINE
outdoorsw1: address=4E.03.28 channels=switch,eventButton,beep,programLock,ledTraffic,ledOnOff,loadSense,lastHeardFrom status=ONLINE
outdoorsw2: address=4D.FF.9D channels=switch,eventButton,beep,programLock,ledTraffic,ledOnOff,loadSense,lastHeardFrom status=ONLINE
playrromlsw: address=43.59.F2 channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=ONLINE
sidestarissw: address=34.76.52 channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=ONLINE
trashcanssw: address=23.FC.A4 channels=switch,eventButton,beep,ledBrightness,programLock,ledTraffic,buttonBeep,lastHeardFrom status=ONLINE

regards
harry

LORDUDE · April 17, 2023, 6:35pm

I did one test to try to debug the Keypads - I disable the hub2, reset one 8 button keypad and linked to he USB PLM which was empty until that point. The binding detects the USB PLM and find the single item in the database but it stays CONGIG PENDING (yellow), i tried toggle disable/enable with the same result, debug logs are included below.

2023-04-17 11:26:35.107 [DEBUG] [ernal.device.database.ModemDBBuilder] - modem db builder finished
2023-04-17 11:26:35.107 [DEBUG] [binding.insteon.internal.driver.Port] - stopping port 192.168.123.9:25105
2023-04-17 11:26:35.108 [DEBUG] [binding.insteon.internal.driver.Port] - reader thread got interrupted!
2023-04-17 11:26:35.108 [DEBUG] [binding.insteon.internal.driver.Port] - exiting reader thread!
2023-04-17 11:26:35.108 [DEBUG] [binding.insteon.internal.driver.Port] - write thread got interrupted!
2023-04-17 11:26:35.108 [DEBUG] [binding.insteon.internal.driver.Port] - exiting writer thread!
2023-04-17 11:26:35.108 [DEBUG] [.internal.driver.RequestQueueManager] - request queue thread interrupted!
2023-04-17 11:26:35.108 [DEBUG] [.internal.driver.RequestQueueManager] - exiting request queue thread!
2023-04-17 11:26:35.109 [DEBUG] [nding.insteon.internal.driver.Poller] - poll queue thread interrupted!
2023-04-17 11:26:35.109 [DEBUG] [nding.insteon.internal.driver.Poller] - exiting poll queue thread!
2023-04-17 11:26:37.801 [DEBUG] [teon.internal.driver.hub.HubIOStream] - hub input stream is null
2023-04-17 11:26:39.429 [DEBUG] [al.discovery.InsteonDiscoveryService] - Initializing InsteonDiscoveryService
2023-04-17 11:26:39.522 [DEBUG] [nternal.handler.InsteonBridgeHandler] - starting bridge insteon:plm:homeusb
2023-04-17 11:26:45.394 [DEBUG] [binding.insteon.internal.driver.Port] - starting port /dev/ttyINSTEON
2023-04-17 11:26:45.428 [DEBUG] [steon.internal.driver.SerialIOStream] - setting /dev/ttyINSTEON baud rate to 19200
2023-04-17 11:26:45.431 [DEBUG] [steon.internal.driver.SerialIOStream] - successfully opened port /dev/ttyINSTEON
2023-04-17 11:26:45.432 [DEBUG] [binding.insteon.internal.driver.Port] - starting reader thread
2023-04-17 11:26:45.432 [DEBUG] [inding.insteon.internal.device.Modem] - initializing modem
2023-04-17 11:26:45.432 [DEBUG] [binding.insteon.internal.driver.Port] - starting writer thread
2023-04-17 11:26:45.432 [DEBUG] [nding.insteon.internal.driver.Poller] - starting poll queue thread
2023-04-17 11:26:45.433 [DEBUG] [ding.insteon.internal.InsteonBinding] - devices: 0 configured, 0 polling, msgs received: 0
2023-04-17 11:26:45.433 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x60|
2023-04-17 11:26:45.433 [DEBUG] [.internal.driver.RequestQueueManager] - starting request queue thread
2023-04-17 11:26:45.452 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeusb:masterkp
2023-04-17 11:26:45.456 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x60|IMAddress:49.FA.46|DeviceCategory:0x03|DeviceSubCategory:0x15|FirmwareVersion:0x9E|ACK/NACK:0x06|
2023-04-17 11:26:45.456 [DEBUG] [ding.insteon.internal.InsteonBinding] - found modem 49.FA.46|deviceCategory:0x03|subCategory:0x15|description:PowerLinc USB Modem|model:2413U|vendor:Insteon|deviceType:NetworkBridge_PLM|firmwareVersion:0x9E|broadcastOnOff->GroupBroadcastOnOff{link=controller}(0:1:0)|broadcastFastOnOff->GroupBroadcastFastOnOff{link=controller}(0:1:0)|broadcastManualChange->GroupBroadcastManualChange{link=controller}(0:2:0)|imEventButton->IMButtonEvent{event=true}(0:0:1)|ledOnOff->IMLEDOnOff(0:1:0)|beep->IMBeep(0:1:0)|imConfigGroup->IMConfigGroup(0:0:0)|ledControl->IMConfigFlags{hidden=true, bit=5}(0:2:2)|monitorMode->IMConfigFlags{bit=6}(0:2:2)|programLock->IMConfigFlags{bit=7}(0:2:2)
2023-04-17 11:26:45.457 [DEBUG] [ernal.device.database.ModemDBBuilder] - starting modem db builder
2023-04-17 11:26:45.457 [DEBUG] [eon.internal.device.database.ModemDB] - clearing modem db!
2023-04-17 11:26:45.957 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x69|
2023-04-17 11:26:45.968 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x69|ACK/NACK:0x06|
2023-04-17 11:26:45.984 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:15.64.7D|LinkData1:0x00|LinkData2:0x00|LinkData3:0x00|
2023-04-17 11:26:46.468 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 11:26:46.495 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 11:26:46.996 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 11:26:47.007 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x15|
2023-04-17 11:26:47.008 [DEBUG] [ernal.device.database.ModemDBBuilder] - got all link records
2023-04-17 11:26:47.008 [DEBUG] [eon.internal.device.database.ModemDB] - the modem database has 1 entries:
2023-04-17 11:26:47.008 [DEBUG] [eon.internal.device.database.ModemDB] - 15.64.7D: modem controls no groups and responds to groups (1)
2023-04-17 11:26:47.008 [DEBUG] [nding.insteon.internal.driver.Poller] - start polling device 49.FA.46
2023-04-17 11:26:47.008 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem database completed
2023-04-17 11:26:47.009 [DEBUG] [nsteon.internal.device.InsteonDevice] - device 15.64.7D found in the modem database.
2023-04-17 11:26:47.010 [DEBUG] [nding.insteon.internal.driver.Poller] - start polling device 15.64.7D
2023-04-17 11:26:47.013 [DEBUG] [nsteon.internal.device.InsteonDevice] - request taken off direct: imConfigGroup OUT:Cmd:0x73|
2023-04-17 11:26:47.013 [DEBUG] [nternal.handler.InsteonDeviceHandler] - masterkp: address=15.64.7D channels=switch,buttonA,buttonB,buttonC,buttonD,eventButtonMain,eventButtonA,eventButtonB,eventButtonC,eventButtonD,beep,ledBrightness,toggleModeButtonA,toggleModeButtonB,toggleModeButtonC,toggleModeButtonD,programLock,ledTraffic,buttonConfig,buttonBeep,lastHeardFrom status=UNKNOWN
2023-04-17 11:26:47.013 [DEBUG] [nsteon.internal.device.InsteonDevice] - next request queue processed in 0 msec, quiettime = 0
2023-04-17 11:26:47.013 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:switch linked
2023-04-17 11:26:47.013 [DEBUG] [.internal.driver.RequestQueueManager] - device queue for 49.FA.46 is empty!
2023-04-17 11:26:47.014 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:switch
2023-04-17 11:26:47.015 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:switch feature=switch kind=STATE isLinked=true
2023-04-17 11:26:47.015 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonA linked
2023-04-17 11:26:47.016 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonA
2023-04-17 11:26:47.017 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonA feature=buttonA kind=STATE isLinked=true
2023-04-17 11:26:47.017 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonB linked
2023-04-17 11:26:47.018 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonB
2023-04-17 11:26:47.019 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonB feature=buttonB kind=STATE isLinked=true
2023-04-17 11:26:47.019 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonC linked
2023-04-17 11:26:47.021 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonC
2023-04-17 11:26:47.021 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonC feature=buttonC kind=STATE isLinked=true
2023-04-17 11:26:47.022 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonD linked
2023-04-17 11:26:47.023 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonD
2023-04-17 11:26:47.024 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonD feature=buttonD kind=STATE isLinked=true
2023-04-17 11:26:47.024 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonMain linked
2023-04-17 11:26:47.024 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonMain feature=eventButtonMain kind=TRIGGER isLinked=false
2023-04-17 11:26:47.024 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonA linked
2023-04-17 11:26:47.024 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonA feature=eventButtonA kind=TRIGGER isLinked=false
2023-04-17 11:26:47.025 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonB linked
2023-04-17 11:26:47.025 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonB feature=eventButtonB kind=TRIGGER isLinked=false
2023-04-17 11:26:47.025 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonC linked
2023-04-17 11:26:47.025 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonC feature=eventButtonC kind=TRIGGER isLinked=false
2023-04-17 11:26:47.026 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonD linked
2023-04-17 11:26:47.026 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonD feature=eventButtonD kind=TRIGGER isLinked=false
2023-04-17 11:26:47.026 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:lastHeardFrom linked
2023-04-17 11:26:47.027 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-17T09:58:18.621-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-17 11:26:47.027 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:lastHeardFrom feature=lastHeardFrom kind=STATE isLinked=true
2023-04-17 11:26:47.028 [DEBUG] [nternal.handler.InsteonBridgeHandler] - homeusb: serialPort=/dev/ttyINSTEON baudRate=19200 devicePollIntervalInSeconds=300 deviceDiscoveryEnabled=true sceneDiscoveryEnabled=true deviceSyncEnabled=true channels=eventButton,ledOnOff,beep,monitorMode,programLock status=UNKNOWN
2023-04-17 11:26:47.028 [DEBUG] [nternal.handler.InsteonBridgeHandler] - channel insteon:plm:homeusb:eventButton linked
2023-04-17 11:26:47.028 [DEBUG] [nternal.handler.InsteonBridgeHandler] - insteon:plm:homeusb:eventButton feature=imEventButton kind=TRIGGER isLinked=false
2023-04-17 11:26:47.029 [DEBUG] [ding.insteon.internal.InsteonBinding] - configured 1 devices:
2023-04-17 11:26:47.029 [DEBUG] [al.discovery.InsteonDiscoveryService] - no missing Insteon device found.
2023-04-17 11:26:47.029 [DEBUG] [al.discovery.InsteonDiscoveryService] - no missing Insteon scene found.
2023-04-17 11:26:47.030 [DEBUG] [ding.insteon.internal.InsteonBinding] - 15.64.7D|deviceCategory:0x02|subCategory:0x0F|productKey:0x000036|description:KeypadLinc On/Off Switch 6-Button|model:2486SWH6|vendor:Insteon|deviceType:SwitchedLightingControl_KeypadButton6|firmwareVersion:0x36|switch->GenericSwitch{link=both}(1:6:7)|buttonGroup->KeypadButtonStatusGroup(0:0:1)|buttonA->KeypadButton{link=both, group=3}(1:6:7)|buttonB->KeypadButton{link=both, group=4}(1:6:7)|buttonC->KeypadButton{link=both, group=5}(1:6:7)|buttonD->KeypadButton{link=both, group=6}(1:6:7)|eventButtonMain->GenericButtonEvent{link=controller, event=true, group=1}(1:0:6)|eventButtonA->GenericButtonEvent{link=controller, event=true, group=3}(1:0:6)|eventButtonB->GenericButtonEvent{link=controller, event=true, group=4}(1:0:6)|eventButtonC->GenericButtonEvent{link=controller, event=true, group=5}(1:0:6)|eventButtonD->GenericButtonEvent{link=controller, event=true, group=6}(1:0:6)|beep->Beep(0:1:0)|extDataGroup->ExtDataGroup{group=1}(0:0:0)|ledBrightness->LEDBrightness{group=1}(0:3:2)|extDataGroupButtonA->ExtDataGroup{group=3}(0:0:0)|onMaskButtonA->KeypadButtonOnMask{hidden=true, group=3}(0:0:2)|offMaskButtonA->KeypadButtonOffMask{hidden=true, group=3}(0:0:2)|toggleModeButtonA->KeypadButtonToggleMode{group=3}(0:2:2)|extDataGroupButtonB->ExtDataGroup{group=4}(0:0:0)|onMaskButtonB->KeypadButtonOnMask{hidden=true, group=4}(0:0:2)|offMaskButtonB->KeypadButtonOffMask{hidden=true, group=4}(0:0:2)|toggleModeButtonB->KeypadButtonToggleMode{group=4}(0:2:2)|extDataGroupButtonC->ExtDataGroup{group=5}(0:0:0)|onMaskButtonC->KeypadButtonOnMask{hidden=true, group=5}(0:0:2)|offMaskButtonC->KeypadButtonOffMask{hidden=true, group=5}(0:0:2)|toggleModeButtonC->KeypadButtonToggleMode{group=5}(0:2:2)|extDataGroupButtonD->ExtDataGroup{group=6}(0:0:0)|onMaskButtonD->KeypadButtonOnMask{hidden=true, group=6}(0:0:2)|offMaskButtonD->KeypadButtonOffMask{hidden=true, group=6}(0:0:2)|toggleModeButtonD->KeypadButtonToggleMode{group=6}(0:2:2)|opFlagsGroup->OpFlagsGroup(0:0:0)|programLock->OpFlags{bit=0, off=0x01, on=0x00}(0:2:1)|ledTraffic->OpFlags{bit=1, off=0x03, on=0x02}(0:2:1)|buttonConfig->KeypadButtonConfig{bit=3, off=0x07, on=0x06}(0:2:1)|ledOnOff->OpFlags{hidden=true, bit=4, inverted=true, off=0x08, on=0x09}(0:2:1)|buttonBeep->OpFlags{bit=5, off=0x0B, on=0x0A}(0:2:1)|insteonEngine->InsteonEngine{hidden=true}(0:0:1)|ping->Ping{hidden=true}(0:0:1)|databaseDelta->DatabaseDelta{hidden=true}(0:0:1)|lastHeardFrom->GenericLastTime{status=true}(1:0:0)
2023-04-17 11:26:47.498 [DEBUG] [ernal.device.database.ModemDBBuilder] - modem db builder finished
2023-04-17 11:26:47.531 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x73|
2023-04-17 11:26:47.551 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x73|IMConfigurationFlags:0x40|Spare1:0x00|Spare2:0x00|ACK/NACK:0x06|
2023-04-17 11:26:47.552 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: broadcastOnOff
2023-04-17 11:26:47.552 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: broadcastFastOnOff
2023-04-17 11:26:47.552 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: broadcastManualChange
2023-04-17 11:26:47.552 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: imEventButton
2023-04-17 11:26:47.552 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: ledOnOff
2023-04-17 11:26:47.553 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: beep
2023-04-17 11:26:47.554 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: imConfigGroup
2023-04-17 11:26:47.554 [DEBUG] [al.handler.feature.MessageDispatcher] - 49.FA.46:ledControl->IMConfigMsgHandler IM
2023-04-17 11:26:47.554 [DEBUG] [ernal.handler.feature.MessageHandler] - IMConfigMsgHandler: IM ledControl changed to OFF
2023-04-17 11:26:47.556 [DEBUG] [al.handler.feature.MessageDispatcher] - 49.FA.46:monitorMode->IMConfigMsgHandler IM
2023-04-17 11:26:47.556 [DEBUG] [ernal.handler.feature.MessageHandler] - IMConfigMsgHandler: IM monitorMode changed to ON
2023-04-17 11:26:47.557 [DEBUG] [al.handler.feature.MessageDispatcher] - 49.FA.46:programLock->IMConfigMsgHandler IM
2023-04-17 11:26:47.557 [DEBUG] [ernal.handler.feature.MessageHandler] - IMConfigMsgHandler: IM programLock changed to OFF
2023-04-17 11:29:02.926 [DEBUG] [nding.insteon.internal.driver.Poller] - stopped polling device 15.64.7D
2023-04-17 11:29:02.929 [DEBUG] [nternal.handler.InsteonBridgeHandler] - removed thing insteon:device:homeusb:masterkp
2023-04-17 11:29:05.325 [DEBUG] [nsteon.internal.device.InsteonDevice] - device 15.64.7D found in the modem database.
2023-04-17 11:29:05.325 [DEBUG] [nding.insteon.internal.driver.Poller] - start polling device 15.64.7D
2023-04-17 11:29:05.339 [DEBUG] [nternal.handler.InsteonDeviceHandler] - masterkp: address=15.64.7D channels=switch,buttonA,buttonB,buttonC,buttonD,eventButtonMain,eventButtonA,eventButtonB,eventButtonC,eventButtonD,beep,ledBrightness,toggleModeButtonA,toggleModeButtonB,toggleModeButtonC,toggleModeButtonD,programLock,ledTraffic,buttonConfig,buttonBeep,lastHeardFrom status=INITIALIZING
2023-04-17 11:29:05.339 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:switch linked
2023-04-17 11:29:05.339 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:switch
2023-04-17 11:29:05.340 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:switch feature=switch kind=STATE isLinked=true
2023-04-17 11:29:05.340 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonA linked
2023-04-17 11:29:05.340 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonA
2023-04-17 11:29:05.340 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonA feature=buttonA kind=STATE isLinked=true
2023-04-17 11:29:05.341 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonB linked
2023-04-17 11:29:05.341 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonB
2023-04-17 11:29:05.341 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonB feature=buttonB kind=STATE isLinked=true
2023-04-17 11:29:05.341 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonC linked
2023-04-17 11:29:05.341 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonC
2023-04-17 11:29:05.342 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonC feature=buttonC kind=STATE isLinked=true
2023-04-17 11:29:05.342 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonD linked
2023-04-17 11:29:05.342 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonD
2023-04-17 11:29:05.342 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonD feature=buttonD kind=STATE isLinked=true
2023-04-17 11:29:05.342 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonMain linked
2023-04-17 11:29:05.343 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonMain feature=eventButtonMain kind=TRIGGER isLinked=false
2023-04-17 11:29:05.343 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonA linked
2023-04-17 11:29:05.343 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonA feature=eventButtonA kind=TRIGGER isLinked=false
2023-04-17 11:29:05.343 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonB linked
2023-04-17 11:29:05.343 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonB feature=eventButtonB kind=TRIGGER isLinked=false
2023-04-17 11:29:05.343 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonC linked
2023-04-17 11:29:05.343 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonC feature=eventButtonC kind=TRIGGER isLinked=false
2023-04-17 11:29:05.343 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonD linked
2023-04-17 11:29:05.344 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonD feature=eventButtonD kind=TRIGGER isLinked=false
2023-04-17 11:29:05.344 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:lastHeardFrom linked
2023-04-17 11:29:05.344 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-17T09:58:18.621-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-17 11:29:05.344 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:lastHeardFrom feature=lastHeardFrom kind=STATE isLinked=true
2023-04-17 11:29:05.344 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeusb:masterkp

jeshab · April 17, 2023, 7:18pm

Thanks very much for providing this information. The device configuration should be polled within the defined bridge device polling interval. Assuming you are using the default value, you should have seen the poll request going out within 5 minutes after the modem has been initialized. It seems that you have tried to disable/enable the device before that time interval. Was there anything logged after that? Also, the product id coming back for your keypad device indicates it is a KeypadLinc On/Off Switch 6-Button 2486SWH6 model. I assume you changed its configuration to be a 8 button keypad now?

As far as the KeypadLinc Timer device, could you provide the product data returned for your device? There is a console command that will output that information.
Looking at the 2484DWH8 model you highlighted and how it is currently setup in the official binding, it just a standard dimmer with no additional button scenes. However, looking at the documentation, you are able to link scenes to such device the same way you would do for a standard keypad. What would be your expectation? Is it just a matter of renaming the button channels?

LORDUDE · April 17, 2023, 7:55pm

The keypad that is now in the USB PLM is still showing 6 button model - i might have linked after reset (as a 6 button) and then converted to 8 button - would that matter? - It is still showing up yellow along with other keypads - biding seem to struggle with the Keypads and outlets

openhab> insteon listDeviceProductData 15.64.7D
The product data for device 15.64.7D is:
deviceCategory:0x02
subCategory:0x0F
productKey:0x000036
description:KeypadLinc On/Off Switch 6-Button
model:2486SWH6
vendor:Insteon
deviceType:SwitchedLightingControl_KeypadButton6
firmwareVersion:0x36
openhab>

Below is the product information for the KeyPad Timer, it still show up CONFIG PENDING - I really had zero expectation from the biding except from turning it on or off - the buttons are there to setup different countdown times - it would be nice it they could be operated remotely similar to the other Keypads buttons - let me know if you need any other information

openhab> insteon listDeviceProductData 17.96.4A
The product data for device 17.96.4A is:
deviceCategory:0x01
subCategory:0x05
productKey:0x000041
description:Keypad Dimmer Countdown Timer
model:2484DWH8
vendor:Insteon
deviceType:DimmableLightingControl_KeypadButton6
firmwareVersion:0x2D
openhab>

jeshab · April 17, 2023, 8:07pm

It doesn’t. As a matter of fact, the binding will remodel the device type once it polls the button configuration for that device. Until it is able to do so, it will show as 6-button model.

Do you see any device poll requests going out in the logs after waiting the full device poll interval?

This is odd that the 6 button device type is getting setup. It might be something I have fixed already on my end. I will release a new version of the binding shortly so that we can troubleshoot properly.

LORDUDE · April 17, 2023, 8:36pm

Here we go, I disable the hub again and watched the logs for the USB PLM only (only one device, KeyPad configured as 8 buttons) - binding seem to be doing it things every 5 minutes but it is showing errors, I assume that is preventing the device from going ONLINE (green) - below are the logs - i did toggle disable/enable again with the same results

2023-04-17 13:16:13.538 [DEBUG] [nternal.handler.InsteonBridgeHandler] - shutting down bridge insteon:hub2:homeeth
2023-04-17 13:16:13.538 [DEBUG] [ternal.device.database.LinkDBBuilder] - link db builder finished for 15.63.AF
2023-04-17 13:16:13.538 [DEBUG] [binding.insteon.internal.driver.Port] - stopping port 192.168.123.9:25105
2023-04-17 13:16:13.538 [DEBUG] [binding.insteon.internal.driver.Port] - reader thread got interrupted!
2023-04-17 13:16:13.539 [DEBUG] [binding.insteon.internal.driver.Port] - exiting reader thread!
2023-04-17 13:16:13.539 [DEBUG] [binding.insteon.internal.driver.Port] - write thread got interrupted!
2023-04-17 13:16:13.539 [DEBUG] [binding.insteon.internal.driver.Port] - exiting writer thread!
2023-04-17 13:16:13.539 [DEBUG] [.internal.driver.RequestQueueManager] - request queue thread interrupted!
2023-04-17 13:16:13.539 [DEBUG] [.internal.driver.RequestQueueManager] - exiting request queue thread!
2023-04-17 13:16:13.539 [DEBUG] [nding.insteon.internal.driver.Poller] - poll queue thread interrupted!
2023-04-17 13:16:13.539 [DEBUG] [nding.insteon.internal.driver.Poller] - exiting poll queue thread!
2023-04-17 13:16:35.331 [DEBUG] [ternal.device.database.LinkDBBuilder] - starting link db builder for 15.64.7D
2023-04-17 13:16:52.106 [DEBUG] [.internal.driver.RequestQueueManager] - pausing request queue thread
2023-04-17 13:16:52.106 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x1F=DIRECT:3:3|command1:0x2F|command2:0x00|userData1:0x00|userData2:0x00|userData3:0x00|userData4:0x00|userData5:0x00|userData6:0x00|userData7:0x00|userData8:0x00|userData9:0x00|userData10:0x00|userData11:0x00|userData12:0x00|userData13:0x00|userData14:0x00|
2023-04-17 13:16:52.130 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: got unknown command code/ext flag 0x62
2023-04-17 13:16:52.130 [DEBUG] [binding.insteon.internal.driver.Port] - got bad data back, must assume message was acked.
2023-04-17 13:16:52.130 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.130 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:16:52.131 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:17:02.010 [DEBUG] [ding.insteon.internal.InsteonBinding] - devices: 1 configured, 2 polling, msgs received: 0
2023-04-17 13:17:06.795 [DEBUG] [ternal.device.database.LinkDBBuilder] - link database download timeout for 15.64.7D, aborting
2023-04-17 13:17:06.795 [DEBUG] [.internal.driver.RequestQueueManager] - resuming request queue thread
2023-04-17 13:17:06.795 [DEBUG] [teon.internal.device.database.LinkDB] - no link records found for 15.64.7D
2023-04-17 13:17:10.045 [DEBUG] [ternal.device.database.LinkDBBuilder] - link db builder finished for 15.64.7D
2023-04-17 13:19:35.439 [DEBUG] [nding.insteon.internal.driver.Poller] - stopped polling device 15.64.7D
2023-04-17 13:19:35.441 [DEBUG] [nternal.handler.InsteonBridgeHandler] - removed thing insteon:device:homeusb:masterkp
2023-04-17 13:19:38.662 [DEBUG] [nsteon.internal.device.InsteonDevice] - device 15.64.7D found in the modem database.
2023-04-17 13:19:38.663 [DEBUG] [nding.insteon.internal.driver.Poller] - start polling device 15.64.7D
2023-04-17 13:19:38.681 [DEBUG] [nternal.handler.InsteonDeviceHandler] - masterkp: address=15.64.7D channels=switch,buttonA,buttonB,buttonC,buttonD,eventButtonMain,eventButtonA,eventButtonB,eventButtonC,eventButtonD,beep,ledBrightness,toggleModeButtonA,toggleModeButtonB,toggleModeButtonC,toggleModeButtonD,programLock,ledTraffic,buttonConfig,buttonBeep,lastHeardFrom status=INITIALIZING
2023-04-17 13:19:38.681 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:switch linked
2023-04-17 13:19:38.681 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:switch
2023-04-17 13:19:38.681 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:switch feature=switch kind=STATE isLinked=true
2023-04-17 13:19:38.681 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonA linked
2023-04-17 13:19:38.681 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonA
2023-04-17 13:19:38.682 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonA feature=buttonA kind=STATE isLinked=true
2023-04-17 13:19:38.682 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonB linked
2023-04-17 13:19:38.682 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonB
2023-04-17 13:19:38.682 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonB feature=buttonB kind=STATE isLinked=true
2023-04-17 13:19:38.682 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonC linked
2023-04-17 13:19:38.683 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonC
2023-04-17 13:19:38.683 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonC feature=buttonC kind=STATE isLinked=true
2023-04-17 13:19:38.683 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:buttonD linked
2023-04-17 13:19:38.683 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state OFF on insteon:device:homeusb:masterkp:buttonD
2023-04-17 13:19:38.684 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:buttonD feature=buttonD kind=STATE isLinked=true
2023-04-17 13:19:38.684 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonMain linked
2023-04-17 13:19:38.684 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonMain feature=eventButtonMain kind=TRIGGER isLinked=false
2023-04-17 13:19:38.684 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonA linked
2023-04-17 13:19:38.684 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonA feature=eventButtonA kind=TRIGGER isLinked=false
2023-04-17 13:19:38.684 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonB linked
2023-04-17 13:19:38.685 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonB feature=eventButtonB kind=TRIGGER isLinked=false
2023-04-17 13:19:38.685 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonC linked
2023-04-17 13:19:38.685 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonC feature=eventButtonC kind=TRIGGER isLinked=false
2023-04-17 13:19:38.685 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:eventButtonD linked
2023-04-17 13:19:38.685 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:eventButtonD feature=eventButtonD kind=TRIGGER isLinked=false
2023-04-17 13:19:38.685 [DEBUG] [nternal.handler.InsteonDeviceHandler] - channel insteon:device:homeusb:masterkp:lastHeardFrom linked
2023-04-17 13:19:38.685 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-17T12:29:49.791-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-17 13:19:38.686 [DEBUG] [nternal.handler.InsteonDeviceHandler] - insteon:device:homeusb:masterkp:lastHeardFrom feature=lastHeardFrom kind=STATE isLinked=true
2023-04-17 13:19:38.686 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeusb:masterkp
2023-04-17 13:22:08.665 [DEBUG] [nsteon.internal.device.InsteonDevice] - request taken off direct: insteonEngine OUT:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x0F=DIRECT:3:3|command1:0x0D|command2:0x00|
2023-04-17 13:22:08.665 [DEBUG] [nsteon.internal.device.InsteonDevice] - next request queue processed in 1000 msec, quiettime = 1000
2023-04-17 13:22:08.665 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x0F=DIRECT:3:3|command1:0x0D|command2:0x00|
2023-04-17 13:22:08.682 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x0F=DIRECT:3:3|command1:0x0D|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:22:09.665 [DEBUG] [.internal.driver.RequestQueueManager] - device queue for 15.64.7D is empty!
2023-04-17 13:27:02.010 [DEBUG] [ding.insteon.internal.InsteonBinding] - devices: 1 configured, 2 polling, msgs received: 0
2023-04-17 13:27:08.664 [DEBUG] [ternal.device.database.LinkDBBuilder] - starting link db builder for 15.64.7D
2023-04-17 13:27:10.220 [DEBUG] [.internal.driver.RequestQueueManager] - pausing request queue thread
2023-04-17 13:27:10.220 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x1F=DIRECT:3:3|command1:0x2F|command2:0x00|userData1:0x00|userData2:0x00|userData3:0x00|userData4:0x00|userData5:0x00|userData6:0x00|userData7:0x00|userData8:0x00|userData9:0x00|userData10:0x00|userData11:0x00|userData12:0x00|userData13:0x00|userData14:0x00|
2023-04-17 13:27:10.230 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: got unknown command code/ext flag 0x62
2023-04-17 13:27:10.230 [DEBUG] [binding.insteon.internal.driver.Port] - got bad data back, must assume message was acked.
2023-04-17 13:27:10.230 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.230 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.230 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.230 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.230 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.231 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.246 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.246 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.246 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.246 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.246 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.246 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.247 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.247 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.247 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.247 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:10.247 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:27:40.156 [DEBUG] [ternal.device.database.LinkDBBuilder] - link database download timeout for 15.64.7D, aborting
2023-04-17 13:27:40.156 [DEBUG] [.internal.driver.RequestQueueManager] - resuming request queue thread
2023-04-17 13:27:40.156 [DEBUG] [teon.internal.device.database.LinkDB] - no link records found for 15.64.7D
2023-04-17 13:27:42.438 [DEBUG] [ternal.device.database.LinkDBBuilder] - link db builder finished for 15.64.7D
2023-04-17 13:32:08.665 [DEBUG] [ternal.device.database.LinkDBBuilder] - starting link db builder for 15.64.7D
2023-04-17 13:32:10.403 [DEBUG] [.internal.driver.RequestQueueManager] - pausing request queue thread
2023-04-17 13:32:10.404 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x1F=DIRECT:3:3|command1:0x2F|command2:0x00|userData1:0x00|userData2:0x00|userData3:0x00|userData4:0x00|userData5:0x00|userData6:0x00|userData7:0x00|userData8:0x00|userData9:0x00|userData10:0x00|userData11:0x00|userData12:0x00|userData13:0x00|userData14:0x00|
2023-04-17 13:32:10.420 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: got unknown command code/ext flag 0x62
2023-04-17 13:32:10.420 [DEBUG] [binding.insteon.internal.driver.Port] - got bad data back, must assume message was acked.
2023-04-17 13:32:10.420 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.420 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.421 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.422 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.422 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.423 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.423 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.435 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.435 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.436 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.436 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.436 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.437 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.437 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.438 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.438 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:10.438 [DEBUG] [.insteon.internal.message.MsgFactory] - bad data received: incoming message does not start with 0x02
2023-04-17 13:32:39.391 [DEBUG] [ternal.device.database.LinkDBBuilder] - link database download timeout for 15.64.7D, aborting
2023-04-17 13:32:39.391 [DEBUG] [.internal.driver.RequestQueueManager] - resuming request queue thread
2023-04-17 13:32:39.392 [DEBUG] [teon.internal.device.database.LinkDB] - no link records found for 15.64.7D
2023-04-17 13:32:42.399 [DEBUG] [ternal.device.database.LinkDBBuilder] - link db builder finished for 15.64.7D

LORDUDE · April 17, 2023, 8:49pm

Here is another reason i would like for a way to cleanup devices database - i have devices that are 10+ years old and during that time at least one USB PLM and one HUB had died and those link remain in many devices, i have tried insteon-terminal but it just does not work well - I might be force to reset every device to cleanup each old database. Device 25.E6.22 is an old hub that no longer exist. I also see some devices with way to many records is that normal?

2023-04-17 13:37:41.230 [DEBUG] [binding.insteon.internal.driver.Port] - starting port 192.168.123.9:25105
2023-04-17 13:37:41.230 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/1?XB=M=1
2023-04-17 13:37:41.233 [DEBUG] [inding.insteon.internal.device.Modem] - initializing modem
2023-04-17 13:37:41.233 [DEBUG] [binding.insteon.internal.driver.Port] - starting reader thread
2023-04-17 13:37:41.233 [DEBUG] [binding.insteon.internal.driver.Port] - starting writer thread
2023-04-17 13:37:41.234 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x60|
2023-04-17 13:37:41.235 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:41.235 [DEBUG] [nding.insteon.internal.driver.Poller] - starting poll queue thread
2023-04-17 13:37:41.235 [DEBUG] [.internal.driver.RequestQueueManager] - starting request queue thread
2023-04-17 13:37:41.237 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?0260=I=3
2023-04-17 13:37:43.167 [DEBUG] [ternal.device.database.LinkDBBuilder] - link db builder finished for 15.64.7D
2023-04-17 13:37:43.168 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:43.171 [DEBUG] [ding.insteon.internal.InsteonBinding] - devices: 0 configured, 0 polling, msgs received: 0
2023-04-17 13:37:43.171 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x60|IMAddress:4C.07.5E|DeviceCategory:0x03|DeviceSubCategory:0x33|FirmwareVersion:0xA5|ACK/NACK:0x06|
2023-04-17 13:37:43.172 [DEBUG] [ding.insteon.internal.InsteonBinding] - found modem 4C.07.5E|deviceCategory:0x03|subCategory:0x33|description:Hub|model:2245-222|vendor:Insteon|deviceType:NetworkBridge_Hub|firmwareVersion:0xA5|broadcastOnOff->GroupBroadcastOnOff{link=controller}(0:1:0)|broadcastFastOnOff->GroupBroadcastFastOnOff{link=controller}(0:1:0)|broadcastManualChange->GroupBroadcastManualChange{link=controller}(0:2:0)|imEventButton->IMButtonEvent{event=true}(0:0:1)|ledOnOff->IMLEDOnOff(0:1:0)|imConfigGroup->IMConfigGroup(0:0:0)|ledControl->IMConfigFlags{hidden=true, bit=5}(0:2:2)|monitorMode->IMConfigFlags{bit=6}(0:2:2)|programLock->IMConfigFlags{bit=7}(0:2:2)
2023-04-17 13:37:43.173 [DEBUG] [ernal.device.database.ModemDBBuilder] - starting modem db builder
2023-04-17 13:37:43.173 [DEBUG] [eon.internal.device.database.ModemDB] - clearing modem db!
2023-04-17 13:37:43.176 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (9) for 33.F6.43
2023-04-17 13:37:43.177 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 33.F6.43 ----------------
2023-04-17 13:37:43.177 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 00.00.00 IDLE group: 0xFC data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.177 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 00.00.00 IDLE group: 0xFC data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.178 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 00.00.00 IDLE group: 0xFC data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.178 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 4C.07.5E RESP group: 0x04 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.179 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.179 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 00.00.00 IDLE group: 0xFC data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.180 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 31.18.E3 IDLE group: 0xFB data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.180 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 31.18.E3 CTRL group: 0xFB data1: 0x03 data2: 0x1C data3: 0xFB
2023-04-17 13:37:43.180 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FBF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.180 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 33.F6.43 -----------------
2023-04-17 13:37:43.189 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:gymroomsw
2023-04-17 13:37:43.191 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (5) for 23.EA.B1
2023-04-17 13:37:43.191 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 23.EA.B1 ----------------
2023-04-17 13:37:43.191 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.191 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.191 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.192 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 25.E6.22 RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.192 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.192 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 23.EA.B1 -----------------
2023-04-17 13:37:43.199 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:alexrsw
2023-04-17 13:37:43.201 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (6) for 4E.03.28
2023-04-17 13:37:43.201 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 4E.03.28 ----------------
2023-04-17 13:37:43.201 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E RESP group: 0x00 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.201 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.202 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.202 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.202 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E RESP group: 0x1B data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.202 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.202 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 4E.03.28 -----------------
2023-04-17 13:37:43.208 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:outdoorsw1
2023-04-17 13:37:43.210 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (17) for 24.F0.F1
2023-04-17 13:37:43.210 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 24.F0.F1 ----------------
2023-04-17 13:37:43.210 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 31.18.E3 CTRL group: 0x01 data1: 0xFF data2: 0x1C data3: 0x00
2023-04-17 13:37:43.210 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 31.18.E3 CTRL group: 0xFB data1: 0xFF data2: 0x1C data3: 0x00
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 1B.F9.38 CTRL group: 0x03 data1: 0x03 data2: 0x1C data3: 0x03
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 1B.F9.38 RESP group: 0x01 data1: 0xFF data2: 0x1C data3: 0x03
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 31.18.E3 CTRL group: 0x01 data1: 0xFF data2: 0x1C data3: 0x00
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 00.00.00 IDLE group: 0xFC data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 34.76.52 CTRL group: 0x04 data1: 0x03 data2: 0x1C data3: 0x04
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 34.76.52 RESP group: 0x01 data1: 0xFF data2: 0x1C data3: 0x04
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FBF 16.91.8F CTRL group: 0x05 data1: 0x03 data2: 0x1C data3: 0x05
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FB7 16.91.8F RESP group: 0x01 data1: 0xFF data2: 0x1C data3: 0x05
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FAF 00.00.00 IDLE group: 0xFC data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FA7 00.00.00 IDLE group: 0xFC data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.211 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F9F 4C.07.5E RESP group: 0x00 data1: 0xFF data2: 0x1C data3: 0x03
2023-04-17 13:37:43.212 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F97 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.212 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F8F 15.64.7D CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.212 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F87 31.18.E3 RESP group: 0x01 data1: 0xFF data2: 0x1C data3: 0x03
2023-04-17 13:37:43.212 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F7F 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.212 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 24.F0.F1 -----------------
2023-04-17 13:37:43.221 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:frontlghtkp
2023-04-17 13:37:43.221 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (6) for 4D.FF.9D
2023-04-17 13:37:43.221 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 4D.FF.9D ----------------
2023-04-17 13:37:43.222 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E RESP group: 0x00 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.222 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.222 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.222 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 25.E6.22 RESP group: 0x00 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.222 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E RESP group: 0x1B data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.222 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.222 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 4D.FF.9D -----------------
2023-04-17 13:37:43.227 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:outdoorsw2
2023-04-17 13:37:43.228 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (4) for 1B.68.10
2023-04-17 13:37:43.228 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 1B.68.10 ----------------
2023-04-17 13:37:43.228 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E RESP group: 0x00 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.228 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.228 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.228 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.228 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 1B.68.10 -----------------
2023-04-17 13:37:43.231 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:mancavetvsw
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (7) for 42.BD.9F
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 42.BD.9F ----------------
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 25.E6.22 CTRL group: 0x01 data1: 0x00 data2: 0x00 data3: 0x01
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 00.00.EE IDLE group: 0x01 data1: 0xFF data2: 0x1C data3: 0x01
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 4C.07.5E RESP group: 0x01 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.232 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 42.BD.9F -----------------
2023-04-17 13:37:43.238 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:dinningdsw
2023-04-17 13:37:43.241 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:fencelsw
2023-04-17 13:37:43.242 [DEBUG] [teon.internal.device.database.LinkDB] - got 30 records for 15.63.AF expected 42
2023-04-17 13:37:43.242 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 15.63.AF ----------------
2023-04-17 13:37:43.242 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.242 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 00.00.00 IDLE group: 0xFC data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.242 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 15.97.5A CTRL group: 0x04 data1: 0x03 data2: 0x1C data3: 0x04
2023-04-17 13:37:43.242 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 15.97.4D CTRL group: 0x04 data1: 0x03 data2: 0x1C data3: 0x04
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 14.69.DF CTRL group: 0x03 data1: 0x03 data2: 0x1C data3: 0x03
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x03
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 4C.07.5E RESP group: 0x1C data1: 0xFF data2: 0x00 data3: 0x01
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x04
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FBF 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FB7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x01
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FAF 4C.07.5E CTRL group: 0x01 data1: 0x00 data2: 0x00 data3: 0x01
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FA7 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F9F 4C.07.5E CTRL group: 0x02 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F97 33.E1.A8 RESP group: 0x01 data1: 0x00 data2: 0x1C data3: 0x06
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F6F 4C.07.5E CTRL group: 0x05 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F67 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F5F 4C.07.5E CTRL group: 0x02 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F57 4C.07.5E CTRL group: 0x03 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F2F 4C.07.5E CTRL group: 0x03 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F27 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F1F 4C.07.5E CTRL group: 0x02 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0EF7 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0EEF 4C.07.5E CTRL group: 0x02 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.243 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0EE7 4C.07.5E CTRL group: 0x03 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.244 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0EDF 4C.07.5E CTRL group: 0x04 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.244 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0ED7 4C.07.5E CTRL group: 0x05 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.244 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0ECF 4C.07.5E CTRL group: 0x06 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.244 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0EC7 4C.07.5E CTRL group: 0x07 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.244 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0EBF 4C.07.5E CTRL group: 0x08 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.244 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0EB7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.244 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 15.63.AF -----------------
2023-04-17 13:37:43.253 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:huttublghtkp
2023-04-17 13:37:43.254 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (2) for 14.6D.A6
2023-04-17 13:37:43.255 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 14.6D.A6 ----------------
2023-04-17 13:37:43.255 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 25.E6.22 CTRL group: 0x01 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.255 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 LAST group: 0x25 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.255 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 14.6D.A6 -----------------
2023-04-17 13:37:43.259 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:basementrsw
2023-04-17 13:37:43.259 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:scene:homeeth:Scene1
2023-04-17 13:37:43.259 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:scene:homeeth:Scene4
2023-04-17 13:37:43.266 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:15647D
2023-04-17 13:37:43.267 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (10) for 1B.F9.38
2023-04-17 13:37:43.267 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 1B.F9.38 ----------------
2023-04-17 13:37:43.267 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00FF 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.267 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00F7 3C.8D.3F RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.267 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00EF 3C.8D.3F CTRL group: 0x01 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.267 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00E7 24.F0.F1 RESP group: 0x03 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.268 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00DF 24.F0.F1 CTRL group: 0x01 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.268 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00D7 25.E6.22 CTRL group: 0x01 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.268 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00CF 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.268 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00C7 4C.07.5E CTRL group: 0x01 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.269 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00BF 4C.07.5E RESP group: 0x01 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.269 [DEBUG] [teon.internal.device.database.LinkDB] - 0x00B7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.269 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 1B.F9.38 -----------------
2023-04-17 13:37:43.274 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:officelsw
2023-04-17 13:37:43.275 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (7) for 1B.3D.90
2023-04-17 13:37:43.275 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 1B.3D.90 ----------------
2023-04-17 13:37:43.275 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.275 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 RESP group: 0x01 data1: 0xFF data2: 0x1C data3: 0x01
2023-04-17 13:37:43.276 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 4C.07.5E CTRL group: 0x01 data1: 0x05 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.276 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 31.18.E3 IDLE group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.276 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 31.18.E3 UNKN group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.276 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.276 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.276 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 1B.3D.90 -----------------
2023-04-17 13:37:43.283 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:ksinkdsw
2023-04-17 13:37:43.286 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:fountainsw
2023-04-17 13:37:43.287 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (9) for 34.76.52
2023-04-17 13:37:43.287 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 34.76.52 ----------------
2023-04-17 13:37:43.287 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 24.F0.F1 RESP group: 0x04 data1: 0xFF data2: 0x1C data3: 0x01
2023-04-17 13:37:43.287 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 RESP group: 0x00 data1: 0xFF data2: 0x1C data3: 0x01
2023-04-17 13:37:43.287 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.287 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 00.00.00 IDLE group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.288 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 3C.8D.3F IDLE group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.288 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 24.F0.F1 CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.288 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.288 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.288 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FBF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.288 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 34.76.52 -----------------
2023-04-17 13:37:43.291 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:sidestarissw
2023-04-17 13:37:43.291 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (5) for 57.85.C7
2023-04-17 13:37:43.291 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 57.85.C7 ----------------
2023-04-17 13:37:43.291 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 25.E6.22 RESP group: 0x00 data1: 0xFF data2: 0x1C data3: 0x02
2023-04-17 13:37:43.292 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0xFF data3: 0x01
2023-04-17 13:37:43.292 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 CTRL group: 0x02 data1: 0x03 data2: 0x1C data3: 0x02
2023-04-17 13:37:43.292 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 4C.07.5E RESP group: 0x00 data1: 0xFF data2: 0x1C data3: 0x01
2023-04-17 13:37:43.292 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.292 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 57.85.C7 -----------------
2023-04-17 13:37:43.296 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:hsideoutlet
2023-04-17 13:37:43.296 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:scene:homeeth:Scene32
2023-04-17 13:37:43.296 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:scene:homeeth:Scene29
2023-04-17 13:37:43.297 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:scene:homeeth:Scene27
2023-04-17 13:37:43.299 [DEBUG] [teon.internal.device.database.LinkDB] - got 11 records for 13.C3.75 expected 15
2023-04-17 13:37:43.299 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 13.C3.75 ----------------
2023-04-17 13:37:43.299 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 14.66.EA CTRL group: 0x06 data1: 0x03 data2: 0x1C data3: 0x06
2023-04-17 13:37:43.299 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 15.97.5A CTRL group: 0x04 data1: 0x03 data2: 0x1C data3: 0x04
2023-04-17 13:37:43.299 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 14.69.DF CTRL group: 0x03 data1: 0x03 data2: 0x1C data3: 0x03
2023-04-17 13:37:43.300 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 4C.07.5E CTRL group: 0x01 data1: 0x00 data2: 0x00 data3: 0x01
2023-04-17 13:37:43.300 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.300 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 25.E6.22 RESP group: 0x00 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.300 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 3C.8D.3F RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x03
2023-04-17 13:37:43.300 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 3C.8D.3F RESP group: 0x00 data1: 0xFF data2: 0x00 data3: 0x01
2023-04-17 13:37:43.300 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FBF 3C.8D.3F CTRL group: 0x01 data1: 0x00 data2: 0x00 data3: 0x01
2023-04-17 13:37:43.300 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F97 3C.8D.3F RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x04
2023-04-17 13:37:43.300 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0F8F 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.300 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 13.C3.75 -----------------
2023-04-17 13:37:43.308 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:decklghtkp
2023-04-17 13:37:43.308 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:backyardsw
2023-04-17 13:37:43.309 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:scene:homeeth:Scene28
2023-04-17 13:37:43.309 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (8) for 14.66.EA
2023-04-17 13:37:43.309 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 14.66.EA ----------------
2023-04-17 13:37:43.310 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 25.E6.22 CTRL group: 0x00 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.310 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 RESP group: 0x00 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.310 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 15.BC.41 RESP group: 0x01 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.310 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 1C.0C.FD RESP group: 0x01 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.310 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 13.C3.75 RESP group: 0x06 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.310 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.311 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF B4.26.22 RESP group: 0x88 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.311 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.311 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 14.66.EA -----------------
2023-04-17 13:37:43.316 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:familytvmsw
2023-04-17 13:37:43.316 [WARN ] [nsteon.internal.device.DeviceFeature] - unknown feature type: extDataGroup
2023-04-17 13:37:43.316 [WARN ] [nsteon.internal.device.InsteonDevice] - device type name:SecurityHealthSafety_MotionSensor|features:motion->WirelessSensorState,daylight->WirelessSensorState,lowBattery->WirelessSensorState,extDataGroup->extDataGroup[batteryLevel, lightLevel],batteryLevel->MotionSensorBatteryLevel,lightLevel->MotionSensorLightLevel,opFlagsGroup->OpFlagsGroup[programLock, ledOnOff, stayAwake],programLock->OpFlags,ledOnOff->OpFlags,stayAwake->OpFlags,heartbeatMonitor->HeartbeatMonitor,insteonEngine->InsteonEngine,ping->Ping,databaseDelta->DatabaseDelta,lastHeardFrom->GenericLastTime|flags:batteryPowered=true references unknown feature type extDataGroup
2023-04-17 13:37:43.317 [WARN ] [nsteon.internal.device.InsteonDevice] - device type name:SecurityHealthSafety_MotionSensor|features:motion->WirelessSensorState,daylight->WirelessSensorState,lowBattery->WirelessSensorState,extDataGroup->extDataGroup[batteryLevel, lightLevel],batteryLevel->MotionSensorBatteryLevel,lightLevel->MotionSensorLightLevel,opFlagsGroup->OpFlagsGroup[programLock, ledOnOff, stayAwake],programLock->OpFlags,ledOnOff->OpFlags,stayAwake->OpFlags,heartbeatMonitor->HeartbeatMonitor,insteonEngine->InsteonEngine,ping->Ping,databaseDelta->DatabaseDelta,lastHeardFrom->GenericLastTime|flags:batteryPowered=true references unknown feature group extDataGroup
2023-04-17 13:37:43.320 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:motionsen1
2023-04-17 13:37:43.321 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (7) for 41.8D.E2
2023-04-17 13:37:43.321 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 41.8D.E2 ----------------
2023-04-17 13:37:43.322 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E RESP group: 0x00 data1: 0xFF data2: 0x1C data3: 0x02
2023-04-17 13:37:43.322 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.322 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 4C.07.5E CTRL group: 0x02 data1: 0x03 data2: 0x1C data3: 0x02
2023-04-17 13:37:43.322 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 25.E6.22 RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.322 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 25.E6.22 CTRL group: 0x01 data1: 0x00 data2: 0x00 data3: 0x01
2023-04-17 13:37:43.322 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 25.E6.22 CTRL group: 0x02 data1: 0x00 data2: 0x00 data3: 0x02
2023-04-17 13:37:43.322 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.323 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 41.8D.E2 -----------------
2023-04-17 13:37:43.327 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:mancaveoutlet
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (7) for 34.75.1C
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 34.75.1C ----------------
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E RESP group: 0x00 data1: 0xFF data2: 0x18 data3: 0x01
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x18 data3: 0x01
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 RESP group: 0x01 data1: 0x00 data2: 0x18 data3: 0x01
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x18 data3: 0x01
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x18 data3: 0x01
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x18 data3: 0x01
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.328 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 34.75.1C -----------------
2023-04-17 13:37:43.330 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:mancavelsw
2023-04-17 13:37:43.331 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (10) for 23.FC.A4
2023-04-17 13:37:43.331 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 23.FC.A4 ----------------
2023-04-17 13:37:43.331 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 17.61.BD IDLE group: 0x01 data1: 0xFF data2: 0x1C data3: 0x01
2023-04-17 13:37:43.332 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 24.F0.F1 IDLE group: 0x04 data1: 0xFF data2: 0x1C data3: 0x01
2023-04-17 13:37:43.332 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 24.F0.F1 IDLE group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.332 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 22.3F.F2 IDLE group: 0x01 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.332 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 31.1B.82 IDLE group: 0x00 data1: 0xFF data2: 0x1C data3: 0x01
2023-04-17 13:37:43.332 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 31.1B.82 IDLE group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.332 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 31.1B.82 IDLE group: 0x07 data1: 0xFF data2: 0x1C data3: 0x01
2023-04-17 13:37:43.332 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.332 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FBF 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.333 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FB7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.333 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 23.FC.A4 -----------------
2023-04-17 13:37:43.336 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:trashcanssw
2023-04-17 13:37:43.336 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:scene:homeeth:Scene34
2023-04-17 13:37:43.337 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (5) for 43.59.F2
2023-04-17 13:37:43.337 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 43.59.F2 ----------------
2023-04-17 13:37:43.337 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 25.E6.22 RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.338 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.338 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.338 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.338 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.338 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 43.59.F2 -----------------
2023-04-17 13:37:43.341 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:playrromlsw
2023-04-17 13:37:43.343 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (6) for 2E.B8.D0
2023-04-17 13:37:43.343 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 2E.B8.D0 ----------------
2023-04-17 13:37:43.343 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 3C.8D.3F RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x00
2023-04-17 13:37:43.343 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 3C.8D.3F CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x00
2023-04-17 13:37:43.343 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1F data3: 0x00
2023-04-17 13:37:43.343 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.344 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.344 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.344 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 2E.B8.D0 -----------------
2023-04-17 13:37:43.348 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:lamplnk2EB8D0
2023-04-17 13:37:43.349 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (8) for 25.45.2D
2023-04-17 13:37:43.349 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 25.45.2D ----------------
2023-04-17 13:37:43.349 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.349 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 RESP group: 0x01 data1: 0x00 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.349 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x01
2023-04-17 13:37:43.349 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 3C.8D.3F RESP group: 0x00 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.349 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 3C.8D.3F CTRL group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.349 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 4C.07.5E RESP group: 0x01 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.349 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 4C.07.5E RESP group: 0x00 data1: 0x7F data2: 0x1F data3: 0x01
2023-04-17 13:37:43.350 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.350 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 25.45.2D -----------------
2023-04-17 13:37:43.355 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:nookdsw
2023-04-17 13:37:43.358 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:leaksen1
2023-04-17 13:37:43.359 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:leaksen2
2023-04-17 13:37:43.360 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (8) for 14.29.45
2023-04-17 13:37:43.360 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 14.29.45 ----------------
2023-04-17 13:37:43.360 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E CTRL group: 0x01 data1: 0x00 data2: 0x18 data3: 0x01
2023-04-17 13:37:43.360 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 4C.07.5E RESP group: 0x00 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.360 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 4C.07.5E RESP group: 0x01 data1: 0xFF data2: 0x18 data3: 0x01
2023-04-17 13:37:43.361 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 25.E6.22 RESP group: 0x00 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.361 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E RESP group: 0x1B data1: 0xFF data2: 0x18 data3: 0x01
2023-04-17 13:37:43.361 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 4C.07.5E CTRL group: 0x01 data1: 0x01 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.361 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 31.18.E3 UNKN group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.361 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.361 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 14.29.45 -----------------
2023-04-17 13:37:43.364 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:lamplnk1429
2023-04-17 13:37:43.365 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (7) for 15.BC.41
2023-04-17 13:37:43.365 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 15.BC.41 ----------------
2023-04-17 13:37:43.365 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 14.66.EA CTRL group: 0x01 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.365 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 CTRL group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.366 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 RESP group: 0x00 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.366 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.366 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E CTRL group: 0x01 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.366 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 4C.07.5E RESP group: 0x22 data1: 0xFF data2: 0x00 data3: 0x00
2023-04-17 13:37:43.366 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.366 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 15.BC.41 -----------------
2023-04-17 13:37:43.368 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:garage1
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (7) for 1C.0C.FD
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 1C.0C.FD ----------------
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 14.66.EA CTRL group: 0x01 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 4C.07.5E RESP group: 0x20 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 25.E6.22 RESP group: 0x00 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 25.E6.22 CTRL group: 0x01 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 25.E6.22 IDLE group: 0x02 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.369 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 1C.0C.FD -----------------
2023-04-17 13:37:43.374 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:garage2
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (7) for 25.48.24
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 25.48.24 ----------------
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 31.18.E3 IDLE group: 0xFB data1: 0x00 data2: 0x1F data3: 0xFB
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 CTRL group: 0x00 data1: 0x03 data2: 0x1F data3: 0xE2
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 RESP group: 0x00 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 31.18.E3 IDLE group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.376 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 25.48.24 -----------------
2023-04-17 13:37:43.383 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:kitchendsw
2023-04-17 13:37:43.384 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (8) for 1B.8E.E4
2023-04-17 13:37:43.384 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 1B.8E.E4 ----------------
2023-04-17 13:37:43.384 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 25.E6.22 RESP group: 0x00 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.385 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.385 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 31.18.E3 IDLE group: 0x00 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.385 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 33.E1.A8 IDLE group: 0x01 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.385 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E CTRL group: 0x01 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.385 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 4C.07.5E RESP group: 0x01 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.385 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FCF 25.E6.22 CTRL group: 0x01 data1: 0xFF data2: 0x1F data3: 0x01
2023-04-17 13:37:43.385 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FC7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.386 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 1B.8E.E4 -----------------
2023-04-17 13:37:43.391 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:adrianlsw
2023-04-17 13:37:43.392 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (6) for 25.4B.F4
2023-04-17 13:37:43.392 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 25.4B.F4 ----------------
2023-04-17 13:37:43.392 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 31.18.E3 IDLE group: 0x00 data1: 0x00 data2: 0x1C data3: 0x00
2023-04-17 13:37:43.393 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 25.E6.22 RESP group: 0x00 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.393 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.393 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 25.E6.22 RESP group: 0x01 data1: 0x00 data2: 0x1C data3: 0x00
2023-04-17 13:37:43.393 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E RESP group: 0x01 data1: 0x00 data2: 0x1F data3: 0x01
2023-04-17 13:37:43.393 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.393 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 25.4B.F4 -----------------
2023-04-17 13:37:43.400 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:islanddsw
2023-04-17 13:37:43.401 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (2) for 14.2B.53
2023-04-17 13:37:43.401 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 14.2B.53 ----------------
2023-04-17 13:37:43.401 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 4C.07.5E RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x00
2023-04-17 13:37:43.401 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.401 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 14.2B.53 -----------------
2023-04-17 13:37:43.408 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:lamplnk142B
2023-04-17 13:37:43.409 [DEBUG] [teon.internal.device.database.LinkDB] - got complete link db records (6) for 2E.B4.20
2023-04-17 13:37:43.409 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 2E.B4.20 ----------------
2023-04-17 13:37:43.409 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 3C.8D.3F RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x00
2023-04-17 13:37:43.409 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 3C.8D.3F CTRL group: 0x01 data1: 0x03 data2: 0x1C data3: 0x00
2023-04-17 13:37:43.410 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FEF 25.E6.22 RESP group: 0x00 data1: 0x00 data2: 0x1C data3: 0x00
2023-04-17 13:37:43.410 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FE7 4C.07.5E RESP group: 0x00 data1: 0xFF data2: 0x1F data3: 0x00
2023-04-17 13:37:43.410 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FDF 4C.07.5E CTRL group: 0x01 data1: 0x03 data2: 0x1F data3: 0x00
2023-04-17 13:37:43.410 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FD7 00.00.00 LAST group: 0x00 data1: 0x00 data2: 0x00 data3: 0x00
2023-04-17 13:37:43.410 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 2E.B4.20 -----------------
2023-04-17 13:37:43.416 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:lamplnk2EB4
2023-04-17 13:37:43.416 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:lamplnk2EB8
2023-04-17 13:37:43.419 [DEBUG] [teon.internal.device.database.LinkDB] - got unexpected last record type for 17.96.4A
2023-04-17 13:37:43.419 [DEBUG] [teon.internal.device.database.LinkDB] - ---------------- start of link records for 17.96.4A ----------------
2023-04-17 13:37:43.419 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FFF 3C.8D.3F RESP group: 0x00 data1: 0xFE data2: 0x1F data3: 0x07
2023-04-17 13:37:43.419 [DEBUG] [teon.internal.device.database.LinkDB] - 0x0FF7 16.91.8F CTRL group: 0x01 data1: 0xFE data2: 0x1F data3: 0x01
2023-04-17 13:37:43.419 [DEBUG] [teon.internal.device.database.LinkDB] - ----------------- end of link records for 17.96.4A -----------------
2023-04-17 13:37:43.427 [DEBUG] [nternal.handler.InsteonBridgeHandler] - added thing insteon:device:homeeth:bathfansw
2023-04-17 13:37:43.673 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x69|
2023-04-17 13:37:43.673 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:43.676 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?0269=I=3
2023-04-17 13:37:46.503 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:46.505 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x69|ACK/NACK:0x06|
2023-04-17 13:37:46.506 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x00|LinkAddr:34.76.52|LinkData1:0x01|LinkData2:0x2A|LinkData3:0x44|
2023-04-17 13:37:47.006 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:34.76.52|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:37:47.006 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:47.009 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?02623476520f1000=I=3
2023-04-17 13:37:47.849 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:47.851 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:34.76.52|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:37:47.851 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:34.76.52|toAddress:4C.07.5E|messageFlags:0x20=ACK_OF_DIRECT:0:0|command1:0x10|command2:0x00|
2023-04-17 13:37:47.851 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:34.76.52|toAddress:02.2A.44|messageFlags:0x8F=BROADCAST:3:3|command1:0x01|command2:0x69|
2023-04-17 13:37:47.851 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:34.76.52|toAddress:02.2A.44|messageFlags:0x8F=BROADCAST:3:3|command1:0x01|command2:0x69|
2023-04-17 13:37:48.351 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:37:48.351 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:48.354 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:37:48.851 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:48.854 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:37:48.854 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:34.76.52|LinkData1:0x00|LinkData2:0x00|LinkData3:0x00|
2023-04-17 13:37:49.355 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:37:49.355 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:49.358 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:37:49.854 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:49.857 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:37:49.857 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xA3|ALLLinkGroup:0x00|LinkAddr:24.F0.F1|LinkData1:0x01|LinkData2:0x2C|LinkData3:0x41|
2023-04-17 13:37:50.357 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:24.F0.F1|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:37:50.357 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:50.361 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026224f0f10f1000=I=3
2023-04-17 13:37:52.372 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:52.374 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:24.F0.F1|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:37:52.374 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:24.F0.F1|toAddress:4C.07.5E|messageFlags:0x2F=ACK_OF_DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:37:52.374 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:24.F0.F1|toAddress:02.2C.41|messageFlags:0x8F=BROADCAST:3:3|command1:0x01|command2:0x69|
2023-04-17 13:37:52.374 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:24.F0.F1|toAddress:02.2C.41|messageFlags:0x8F=BROADCAST:3:3|command1:0x01|command2:0x69|
2023-04-17 13:37:52.874 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:37:52.874 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:52.877 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:37:54.163 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:54.165 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:37:54.166 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:24.F0.F1|LinkData1:0x00|LinkData2:0x00|LinkData3:0x00|
2023-04-17 13:37:54.666 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:37:54.666 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:54.669 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:37:57.474 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:57.476 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:37:57.476 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x00|LinkAddr:33.F6.43|LinkData1:0x01|LinkData2:0x2A|LinkData3:0x43|
2023-04-17 13:37:57.977 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:33.F6.43|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:37:57.977 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:57.979 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026233f6430f1000=I=3
2023-04-17 13:37:58.476 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:58.479 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:33.F6.43|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:37:58.479 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:33.F6.43|toAddress:4C.07.5E|messageFlags:0x20=ACK_OF_DIRECT:0:0|command1:0x10|command2:0x00|
2023-04-17 13:37:58.479 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:33.F6.43|toAddress:02.2A.43|messageFlags:0x8F=BROADCAST:3:3|command1:0x01|command2:0x68|
2023-04-17 13:37:58.479 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:33.F6.43|toAddress:02.2A.43|messageFlags:0x8F=BROADCAST:3:3|command1:0x01|command2:0x68|
2023-04-17 13:37:58.979 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:37:58.979 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:37:58.982 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:38:00.629 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:00.632 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:38:00.633 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x00|LinkAddr:25.4B.F4|LinkData1:0x01|LinkData2:0x20|LinkData3:0x41|
2023-04-17 13:38:01.133 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:25.4B.F4|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:38:01.133 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:01.136 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?0262254bf40f1000=I=3
2023-04-17 13:38:03.625 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:03.628 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:25.4B.F4|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:38:03.629 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:25.4B.F4|toAddress:4C.07.5E|messageFlags:0x20=ACK_OF_DIRECT:0:0|command1:0x10|command2:0x00|
2023-04-17 13:38:03.629 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:25.4B.F4|toAddress:01.20.41|messageFlags:0x8B=BROADCAST:2:3|command1:0x01|command2:0x72|
2023-04-17 13:38:03.629 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:25.4B.F4|toAddress:01.20.41|messageFlags:0x8B=BROADCAST:2:3|command1:0x01|command2:0x72|
2023-04-17 13:38:04.129 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:38:04.129 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:04.132 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:38:04.738 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:04.740 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:38:04.741 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xEA|ALLLinkGroup:0x00|LinkAddr:25.48.24|LinkData1:0x01|LinkData2:0x20|LinkData3:0x41|
2023-04-17 13:38:05.241 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:25.48.24|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:38:05.241 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:05.243 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?02622548240f1000=I=3
2023-04-17 13:38:05.776 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:05.779 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:25.48.24|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:38:05.779 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:25.48.24|toAddress:4C.07.5E|messageFlags:0x21=ACK_OF_DIRECT:0:1|command1:0x10|command2:0x00|
2023-04-17 13:38:05.779 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:25.48.24|toAddress:01.20.41|messageFlags:0x8F=BROADCAST:3:3|command1:0x01|command2:0x72|
2023-04-17 13:38:05.779 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:25.48.24|toAddress:01.20.41|messageFlags:0x8F=BROADCAST:3:3|command1:0x01|command2:0x72|
2023-04-17 13:38:06.279 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:38:06.279 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:06.282 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:38:06.779 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:06.781 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:38:06.782 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:25.45.2D|LinkData1:0x01|LinkData2:0x20|LinkData3:0x41|
2023-04-17 13:38:07.282 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:25.45.2D|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:38:07.282 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:07.284 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026225452d0f1000=I=3
2023-04-17 13:38:08.400 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:08.403 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:25.45.2D|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:38:08.403 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:25.45.2D|toAddress:4C.07.5E|messageFlags:0x20=ACK_OF_DIRECT:0:0|command1:0x10|command2:0x00|
2023-04-17 13:38:08.404 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:25.45.2D|toAddress:01.20.41|messageFlags:0x8B=BROADCAST:2:3|command1:0x01|command2:0x72|
2023-04-17 13:38:08.404 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:25.45.2D|toAddress:01.20.41|messageFlags:0x8B=BROADCAST:2:3|command1:0x01|command2:0x72|
2023-04-17 13:38:08.904 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:38:08.904 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:08.907 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:38:10.535 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:10.538 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:38:10.538 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xAA|ALLLinkGroup:0x00|LinkAddr:1B.F9.38|LinkData1:0x01|LinkData2:0x16|LinkData3:0x39|
2023-04-17 13:38:11.039 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:1B.F9.38|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:38:11.039 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:11.042 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?02621bf9380f1000=I=3
2023-04-17 13:38:12.216 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:12.218 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:1B.F9.38|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:38:12.719 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:38:12.719 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:12.721 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:38:12.721 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:1B.F9.38|toAddress:4C.07.5E|messageFlags:0x2B=ACK_OF_DIRECT:2:3|command1:0x10|command2:0x00|
2023-04-17 13:38:13.771 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:13.775 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:38:13.775 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:1B.F9.38|LinkData1:0x00|LinkData2:0x00|LinkData3:0x00|
2023-04-17 13:38:14.275 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:1B.F9.38|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:38:14.275 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:14.278 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?02621bf9380f1000=I=3
2023-04-17 13:38:18.362 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:18.364 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:1B.F9.38|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:38:18.365 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:1B.F9.38|toAddress:4C.07.5E|messageFlags:0x2B=ACK_OF_DIRECT:2:3|command1:0x10|command2:0x00|
2023-04-17 13:38:18.365 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:1B.F9.38|toAddress:02.16.39|messageFlags:0x87=BROADCAST:1:3|command1:0x01|command2:0x00|
2023-04-17 13:38:18.365 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:1B.F9.38|toAddress:02.16.39|messageFlags:0x87=BROADCAST:1:3|command1:0x01|command2:0x00|
2023-04-17 13:38:18.865 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:38:18.865 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:18.869 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:38:21.708 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:21.710 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:38:21.710 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x00|LinkAddr:1B.3D.90|LinkData1:0x01|LinkData2:0x20|LinkData3:0x40|
2023-04-17 13:38:22.210 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:1B.3D.90|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:38:22.211 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:22.213 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?02621b3d900f1000=I=3
2023-04-17 13:38:26.442 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:26.445 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:1B.3D.90|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:38:26.445 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:1B.3D.90|toAddress:4C.07.5E|messageFlags:0x20=ACK_OF_DIRECT:0:0|command1:0x10|command2:0x00|
2023-04-17 13:38:26.445 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:1B.3D.90|toAddress:01.20.40|messageFlags:0x8B=BROADCAST:2:3|command1:0x01|command2:0x00|
2023-04-17 13:38:26.445 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:1B.3D.90|toAddress:01.20.40|messageFlags:0x8B=BROADCAST:2:3|command1:0x01|command2:0x00|
2023-04-17 13:38:26.945 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x6A|
2023-04-17 13:38:26.945 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:26.947 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026a=I=3
2023-04-17 13:38:29.866 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:29.869 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x6A|ACK/NACK:0x06|
2023-04-17 13:38:29.869 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x57|RecordFlags:0xAA|ALLLinkGroup:0x00|LinkAddr:15.64.7D|LinkData1:0x01|LinkData2:0x0F|LinkData3:0x36|
2023-04-17 13:38:30.370 [DEBUG] [binding.insteon.internal.driver.Port] - writing: OUT:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|
2023-04-17 13:38:30.370 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:30.373 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/3?026215647d0f1000=I=3
2023-04-17 13:38:30.946 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:15.64.7D|toAddress:02.0F.36|messageFlags:0x8F=BROADCAST:3:3|command1:0x01|command2:0x00|
2023-04-17 13:38:30.946 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: switch
2023-04-17 13:38:30.946 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: buttonGroup
2023-04-17 13:38:30.946 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: buttonA
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: buttonB
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: buttonC
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: buttonD
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: eventButtonMain
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: eventButtonA
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: eventButtonB
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: eventButtonC
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: eventButtonD
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: beep
2023-04-17 13:38:30.947 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: extDataGroup
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: ledBrightness
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: extDataGroupButtonA
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: onMaskButtonA
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: offMaskButtonA
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: toggleModeButtonA
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: extDataGroupButtonB
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: onMaskButtonB
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: offMaskButtonB
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: toggleModeButtonB
2023-04-17 13:38:30.948 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: extDataGroupButtonC
2023-04-17 13:38:30.949 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: onMaskButtonC
2023-04-17 13:38:30.949 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: offMaskButtonC
2023-04-17 13:38:30.949 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: toggleModeButtonC
2023-04-17 13:38:30.949 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: extDataGroupButtonD
2023-04-17 13:38:30.949 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: onMaskButtonD
2023-04-17 13:38:30.949 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: offMaskButtonD
2023-04-17 13:38:30.949 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: toggleModeButtonD
2023-04-17 13:38:30.949 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: opFlagsGroup
2023-04-17 13:38:30.949 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: programLock
2023-04-17 13:38:30.950 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: ledTraffic
2023-04-17 13:38:30.950 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: buttonConfig
2023-04-17 13:38:30.950 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: ledOnOff
2023-04-17 13:38:30.950 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: buttonBeep
2023-04-17 13:38:30.950 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: insteonEngine
2023-04-17 13:38:30.950 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: ping
2023-04-17 13:38:30.950 [DEBUG] [nsteon.internal.device.InsteonDevice] - ----- applying message to feature: databaseDelta
2023-04-17 13:38:30.950 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler BROADCAST group:N/A
2023-04-17 13:38:30.951 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-17T13:38:30.946-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-17 13:38:31.857 [DEBUG] [teon.internal.driver.hub.HubIOStream] - getting http://192.168.123.9:25105/buffstatus.xml
2023-04-17 13:38:31.860 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x62|toAddress:15.64.7D|messageFlags:0x0F=DIRECT:3:3|command1:0x10|command2:0x00|ACK/NACK:0x06|
2023-04-17 13:38:31.860 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:15.64.7D|toAddress:4C.07.5E|messageFlags:0x2B=ACK_OF_DIRECT:2:3|command1:0x10|command2:0x00|
2023-04-17 13:38:31.860 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:15.64.7D|toAddress:02.0F.36|messageFlags:0x8B=BROADCAST:2:3|command1:0x01|command2:0x00|
2023-04-17 13:38:31.860 [DEBUG] [binding.insteon.internal.driver.Port] - got msg: IN:Cmd:0x50|fromAddress:15.64.7D|toAddress:02.0F.36|messageFlags:0x8B=BROADCAST:2:3|command1:0x01|command2:0x00|

jeshab · April 17, 2023, 9:31pm

There seems to be some kind of communication issue. Is this with the Hub or PLM device? Let me release a new version of the binding which includes some improvement related to the communication.

It might be the best solutions. I added some support to remove a device from a modem (improved in the upcoming binding release) but if the latter isn’t available, resetting the device or using the insteon-terminal tool is the only option at the moment.

It depends on how many links that have been setup and the device type. A keypad generally have a lot more records.

LORDUDE · April 17, 2023, 9:57pm

This is for the PM - I reset a lamp link and added to the USB PLM to improve the communication, i’m able to read the PLM/Keypad/LampLink databases using insteon-terminal - the LampLink and Keypad are now ONLINE and the Keypad is showing at 8 button device - one issue solved!!

I will continue resetting devices and linking them to the PLM only since i’m moving away from the HUB anyway. Let me know when you have a new version of the binding for me to try, i still have several unhappy devices which i suspect it could be communication issues

LORDUDE · April 18, 2023, 10:15pm

@jeshab I think i found an issue with the binding - it does not seem to be publishing lastHeardFrom for switches - i was watching the logs and i can see updated from most of the devices but lastHeardFrom for switches is still NULL - it works for KeyPad/LampLink/Motion but not wall switches

2023-04-18 14:48:17.490 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:48:17.490-0700 on insteon:device:homeusb:gymsw:lastHeardFrom
2023-04-18 14:48:38.923 [DEBUG] [al.handler.feature.MessageDispatcher] - 43.59.F2:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:48:38.923 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:48:38.922-0700 on insteon:device:homeusb:playroomsw:lastHeardFrom
2023-04-18 14:49:00.403 [DEBUG] [al.handler.feature.MessageDispatcher] - 1B.8E.E4:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:49:00.403 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:49:00.403-0700 on insteon:device:homeusb:adriansw:lastHeardFrom
2023-04-18 14:49:21.787 [DEBUG] [al.handler.feature.MessageDispatcher] - 4D.FF.9D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:49:21.788 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:49:21.787-0700 on insteon:device:homeusb:outdoorsw2:lastHeardFrom
2023-04-18 14:49:43.203 [DEBUG] [al.handler.feature.MessageDispatcher] - 4E.03.28:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:49:43.203 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:49:43.203-0700 on insteon:device:homeusb:outdoorsw1:lastHeardFrom
2023-04-18 14:50:47.436 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B8.A3:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:50:47.436 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:50:47.436-0700 on insteon:device:homeusb:LL2EB8A3:lastHeardFrom
2023-04-18 14:51:08.869 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B6.18:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:51:08.869 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:51:08.868-0700 on insteon:device:homeusb:LL2EB618:lastHeardFrom
2023-04-18 14:51:51.749 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B4.20:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:51:51.749 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:51:51.748-0700 on insteon:device:homeusb:LL2EB420:lastHeardFrom
2023-04-18 14:52:13.182 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:52:13.182 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:52:13.181-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-18 14:52:14.174 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:52:14.174 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:52:14.172-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-18 14:52:14.369 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:52:14.369 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:52:14.364-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-18 14:52:38.900 [DEBUG] [al.handler.feature.MessageDispatcher] - 23.EA.B1:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:52:38.900 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:52:38.899-0700 on insteon:device:homeusb:alexsw:lastHeardFrom
2023-04-18 14:53:05.291 [DEBUG] [al.handler.feature.MessageDispatcher] - 14.2B.53:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:53:05.291 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:53:05.290-0700 on insteon:device:homeusb:LL142B53:lastHeardFrom
2023-04-18 14:53:17.495 [DEBUG] [al.handler.feature.MessageDispatcher] - 33.F6.43:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:53:17.495 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:53:17.494-0700 on insteon:device:homeusb:gymsw:lastHeardFrom
2023-04-18 14:53:38.927 [DEBUG] [al.handler.feature.MessageDispatcher] - 43.59.F2:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:53:38.927 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:53:38.926-0700 on insteon:device:homeusb:playroomsw:lastHeardFrom
2023-04-18 14:54:00.406 [DEBUG] [al.handler.feature.MessageDispatcher] - 1B.8E.E4:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:54:00.406 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:54:00.406-0700 on insteon:device:homeusb:adriansw:lastHeardFrom
2023-04-18 14:54:21.791 [DEBUG] [al.handler.feature.MessageDispatcher] - 4D.FF.9D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:54:21.791 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:54:21.790-0700 on insteon:device:homeusb:outdoorsw2:lastHeardFrom
2023-04-18 14:54:43.271 [DEBUG] [al.handler.feature.MessageDispatcher] - 4E.03.28:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:54:43.271 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:54:43.270-0700 on insteon:device:homeusb:outdoorsw1:lastHeardFrom
2023-04-18 14:55:47.440 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B8.A3:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:55:47.440 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:55:47.439-0700 on insteon:device:homeusb:LL2EB8A3:lastHeardFrom
2023-04-18 14:56:08.872 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B6.18:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:56:08.872 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:56:08.871-0700 on insteon:device:homeusb:LL2EB618:lastHeardFrom
2023-04-18 14:56:51.737 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B4.20:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:56:51.737 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:56:51.736-0700 on insteon:device:homeusb:LL2EB420:lastHeardFrom
2023-04-18 14:57:13.185 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:57:13.185 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:57:13.184-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-18 14:57:14.176 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:57:14.176 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:57:14.175-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-18 14:58:07.853 [DEBUG] [al.handler.feature.MessageDispatcher] - 23.EA.B1:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:58:07.853 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:58:07.852-0700 on insteon:device:homeusb:alexsw:lastHeardFrom
2023-04-18 14:58:08.365 [DEBUG] [al.handler.feature.MessageDispatcher] - 14.2B.53:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:58:08.365 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:58:08.364-0700 on insteon:device:homeusb:LL142B53:lastHeardFrom
2023-04-18 14:58:17.497 [DEBUG] [al.handler.feature.MessageDispatcher] - 33.F6.43:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:58:17.498 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:58:17.497-0700 on insteon:device:homeusb:gymsw:lastHeardFrom
2023-04-18 14:58:38.929 [DEBUG] [al.handler.feature.MessageDispatcher] - 43.59.F2:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:58:38.929 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:58:38.929-0700 on insteon:device:homeusb:playroomsw:lastHeardFrom
2023-04-18 14:59:00.393 [DEBUG] [al.handler.feature.MessageDispatcher] - 1B.8E.E4:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:59:00.393 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:59:00.392-0700 on insteon:device:homeusb:adriansw:lastHeardFrom
2023-04-18 14:59:21.778 [DEBUG] [al.handler.feature.MessageDispatcher] - 4D.FF.9D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:59:21.778 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:59:21.777-0700 on insteon:device:homeusb:outdoorsw2:lastHeardFrom
2023-04-18 14:59:43.210 [DEBUG] [al.handler.feature.MessageDispatcher] - 4E.03.28:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:59:43.210 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:59:43.209-0700 on insteon:device:homeusb:outdoorsw1:lastHeardFrom
2023-04-18 14:59:43.401 [DEBUG] [al.handler.feature.MessageDispatcher] - 4E.03.28:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 14:59:43.401 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T14:59:43.401-0700 on insteon:device:homeusb:outdoorsw1:lastHeardFrom
2023-04-18 15:00:47.442 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B8.A3:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:00:47.442 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:00:47.441-0700 on insteon:device:homeusb:LL2EB8A3:lastHeardFrom
2023-04-18 15:01:08.875 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B6.18:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:01:08.875 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:01:08.874-0700 on insteon:device:homeusb:LL2EB618:lastHeardFrom
2023-04-18 15:01:51.739 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B4.20:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:01:51.739 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:01:51.738-0700 on insteon:device:homeusb:LL2EB420:lastHeardFrom
2023-04-18 15:02:13.187 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:02:13.187 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:02:13.186-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-18 15:02:14.181 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:02:14.182 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:02:14.179-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-18 15:03:04.640 [DEBUG] [al.handler.feature.MessageDispatcher] - 23.EA.B1:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:03:04.640 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:03:04.640-0700 on insteon:device:homeusb:alexsw:lastHeardFrom
2023-04-18 15:03:05.153 [DEBUG] [al.handler.feature.MessageDispatcher] - 14.2B.53:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:03:05.153 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:03:05.152-0700 on insteon:device:homeusb:LL142B53:lastHeardFrom
2023-04-18 15:03:17.500 [DEBUG] [al.handler.feature.MessageDispatcher] - 33.F6.43:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:03:17.500 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:03:17.500-0700 on insteon:device:homeusb:gymsw:lastHeardFrom
2023-04-18 15:03:38.932 [DEBUG] [al.handler.feature.MessageDispatcher] - 43.59.F2:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:03:38.932 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:03:38.931-0700 on insteon:device:homeusb:playroomsw:lastHeardFrom
2023-04-18 15:03:39.124 [DEBUG] [al.handler.feature.MessageDispatcher] - 43.59.F2:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:03:39.124 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:03:39.123-0700 on insteon:device:homeusb:playroomsw:lastHeardFrom
2023-04-18 15:04:00.411 [DEBUG] [al.handler.feature.MessageDispatcher] - 1B.8E.E4:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:04:00.411 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:04:00.411-0700 on insteon:device:homeusb:adriansw:lastHeardFrom
2023-04-18 15:04:05.578 [DEBUG] [al.handler.feature.MessageDispatcher] - 4E.03.28:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:04:05.578 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:04:05.577-0700 on insteon:device:homeusb:outdoorsw1:lastHeardFrom
2023-04-18 15:04:05.722 [DEBUG] [al.handler.feature.MessageDispatcher] - 4E.03.28:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:04:05.723 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:04:05.721-0700 on insteon:device:homeusb:outdoorsw1:lastHeardFrom
2023-04-18 15:04:21.780 [DEBUG] [al.handler.feature.MessageDispatcher] - 4D.FF.9D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:04:21.780 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:04:21.779-0700 on insteon:device:homeusb:outdoorsw2:lastHeardFrom
2023-04-18 15:04:43.260 [DEBUG] [al.handler.feature.MessageDispatcher] - 4E.03.28:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:04:43.261 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:04:43.260-0700 on insteon:device:homeusb:outdoorsw1:lastHeardFrom
2023-04-18 15:05:04.149 [DEBUG] [al.handler.feature.MessageDispatcher] - 4D.FF.9D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:05:04.149 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:05:04.148-0700 on insteon:device:homeusb:outdoorsw2:lastHeardFrom
2023-04-18 15:05:20.879 [DEBUG] [al.handler.feature.MessageDispatcher] - 4E.03.28:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:05:20.879 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:05:20.878-0700 on insteon:device:homeusb:outdoorsw1:lastHeardFrom
2023-04-18 15:05:47.444 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B8.A3:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:05:47.444 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:05:47.443-0700 on insteon:device:homeusb:LL2EB8A3:lastHeardFrom
2023-04-18 15:05:47.638 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B8.A3:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:05:47.638 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:05:47.636-0700 on insteon:device:homeusb:LL2EB8A3:lastHeardFrom
2023-04-18 15:06:08.877 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B6.18:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:06:08.878 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:06:08.876-0700 on insteon:device:homeusb:LL2EB618:lastHeardFrom
2023-04-18 15:06:51.741 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B4.20:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:06:51.742 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:06:51.741-0700 on insteon:device:homeusb:LL2EB420:lastHeardFrom
2023-04-18 15:07:13.189 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:07:13.189 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:07:13.189-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-18 15:07:14.182 [DEBUG] [al.handler.feature.MessageDispatcher] - 15.64.7D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:07:14.182 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:07:14.180-0700 on insteon:device:homeusb:masterkp:lastHeardFrom
2023-04-18 15:08:04.978 [DEBUG] [al.handler.feature.MessageDispatcher] - 23.EA.B1:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:08:04.978 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:08:04.978-0700 on insteon:device:homeusb:alexsw:lastHeardFrom
2023-04-18 15:08:05.586 [DEBUG] [al.handler.feature.MessageDispatcher] - 14.2B.53:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:08:05.586 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:08:05.585-0700 on insteon:device:homeusb:LL142B53:lastHeardFrom
2023-04-18 15:08:17.486 [DEBUG] [al.handler.feature.MessageDispatcher] - 33.F6.43:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:08:17.486 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:08:17.485-0700 on insteon:device:homeusb:gymsw:lastHeardFrom
2023-04-18 15:08:38.934 [DEBUG] [al.handler.feature.MessageDispatcher] - 43.59.F2:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:08:38.934 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:08:38.933-0700 on insteon:device:homeusb:playroomsw:lastHeardFrom
2023-04-18 15:09:00.398 [DEBUG] [al.handler.feature.MessageDispatcher] - 1B.8E.E4:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:09:00.398 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:09:00.398-0700 on insteon:device:homeusb:adriansw:lastHeardFrom
2023-04-18 15:09:21.783 [DEBUG] [al.handler.feature.MessageDispatcher] - 4D.FF.9D:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:09:21.783 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:09:21.782-0700 on insteon:device:homeusb:outdoorsw2:lastHeardFrom
2023-04-18 15:09:43.215 [DEBUG] [al.handler.feature.MessageDispatcher] - 4E.03.28:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:09:43.215 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:09:43.214-0700 on insteon:device:homeusb:outdoorsw1:lastHeardFrom
2023-04-18 15:10:47.448 [DEBUG] [al.handler.feature.MessageDispatcher] - 2E.B8.A3:lastHeardFrom->LastTimeMsgHandler ACK_OF_DIRECT group:N/A
2023-04-18 15:10:47.448 [DEBUG] [ternal.handler.InsteonChannelHandler] - publishing state 2023-04-18T15:10:47.447-0700 on insteon:device:homeusb:LL2EB8A3:lastHeardFrom

LORDUDE · April 22, 2023, 4:50pm

@jeshab I’m going back to the stable insteon binding because I can not make all my devices to work with the beta binding. After a week if trying different configurations, linking and unlinking devices, moving them between HUB and PLM I still have devices that are not recognized or show up offline (not linked). For the devices OFFLINE in Openhab it says the devices are not int he database however they are linked and when i check insteon-termial they are listed - if i switch the PLM to home assistant it finds all devices and HA is able to operate every device without issues. For some reason HA and insteon-terminal see all 37 devices in the database but insteon beta binding only find 35, even the old binding find all devices. All the devices with config pending are old devices that are not dual band, that is the only thing in common.

openhab> insteon listModemDatabase
The modem database for 49.FA.46 contains 35 entries:
13.C3.75: modem controls groups (1) and responds to groups (1)
14.29.45: modem controls groups (1) and responds to groups (1)
14.2B.53: modem controls groups (1) and responds to groups (1)
14.66.EA: modem controls groups (1) and responds to groups (1)
14.6D.A6: modem controls groups (1) and responds to groups (1)
15.63.AF: modem controls groups (1) and responds to groups (1)
15.64.7D: modem controls groups (1) and responds to groups (1)
15.BC.41: modem controls groups (1) and responds to groups (1)
17.96.4A: modem controls groups (1) and responds to groups (1)
1B.3D.90: modem controls groups (1) and responds to no groups
1B.68.10: modem controls no groups and responds to groups (1)
1B.8E.E4: modem controls groups (1) and responds to groups (1)
1B.F9.38: modem controls groups (0,1) and responds to groups (1)
1C.0C.FD: modem controls groups (1) and responds to groups (1)
23.17.97: modem controls no groups and responds to groups (1)
23.EA.B1: modem controls groups (1) and responds to no groups
23.FC.A4: modem controls groups (1) and responds to groups (1)
24.F0.F1: modem controls groups (1) and responds to no groups
25.45.2D: modem controls groups (1) and responds to no groups
25.48.24: modem controls groups (1) and responds to no groups
25.4B.F4: modem controls groups (1) and responds to no groups
2E.B4.20: modem controls groups (1) and responds to no groups
2E.B6.18: modem controls groups (1) and responds to no groups
2E.B8.A3: modem controls groups (1) and responds to no groups
2E.B8.D0: modem controls groups (1) and responds to no groups
33.F6.43: modem controls groups (1) and responds to no groups
34.75.1C: modem controls groups (1) and responds to no groups
34.76.52: modem controls groups (1) and responds to no groups
41.8D.E2: modem controls groups (1) and responds to groups (1)
42.BD.9F: modem controls groups (1) and responds to no groups
43.59.F2: modem controls groups (1) and responds to no groups
4B.0E.26: modem controls groups (1) and responds to groups (1)
4D.FF.9D: modem controls groups (1) and responds to no groups
4E.03.28: modem controls groups (1) and responds to groups (1)
57.85.C7: modem controls groups (1) and responds to no groups

Terminal ready!
>>> hub5.getdb()
0000 OUT5_ManCaveCouchOutlet        41.8D.E2  RESP  10100010 group: 01 data: 02 39 44
0000 OUT5_ManCaveCouchOutlet        41.8D.E2  CTRL  11100010 group: 01 data: ff 1c 01
0000 PLY_PlayRoomoLights            43.59.F2  RESP  10100010 group: 01 data: 02 2a 45
0000 PLY_PlayRoomoLights            43.59.F2  CTRL  11100010 group: 01 data: 02 2a 45
0000 KIN_KIslantLights              25.4B.F4  RESP  10100010 group: 01 data: 01 20 41
0000 KIN_KIslantLights              25.4B.F4  CTRL  11100010 group: 01 data: 01 20 41
0000 ALX_AlexLights                 23.EA.B1  RESP  10100010 group: 01 data: 02 2a 43
0000 ALX_AlexLights                 23.EA.B1  CTRL  11100010 group: 01 data: 02 2a 43
0000 NOK_NookLights                 25.45.2D  RESP  10100010 group: 01 data: 01 20 41
0000 NOK_NookLights                 25.45.2D  CTRL  11100010 group: 01 data: 01 20 41
0000 OUTB_OutDoor2                  4D.FF.9D  RESP  10100010 group: 01 data: 02 38 43
0000 OUTB_OutDoor2                  4D.FF.9D  CTRL  11100010 group: 01 data: 02 38 43
0000 FAN_BathRoomFan                17.96.4A  RESP  10100010 group: 01 data: 01 05 2d
0000 FAN_BathRoomFan                17.96.4A  CTRL  11100010 group: 01 data: 01 05 2d
0000 BSL_BasementLights             14.6D.A6  RESP  10100010 group: 01 data: 02 15 38
0000 BSL_BasementLights             14.6D.A6  CTRL  11100010 group: 01 data: 02 15 38
0000 MCV_ManCaveLights              34.75.1C  RESP  10100010 group: 01 data: 02 2a 44
0000 MCV_ManCaveLights              34.75.1C  CTRL  11100010 group: 01 data: 02 2a 44
0000 OUT4_TVMoodOutlet              14.66.EA  RESP  10100010 group: 01 data: 00 00 01
0000 OUT4_TVMoodOutlet              14.66.EA  CTRL  11100010 group: 01 data: ff 23 01
0000 LM1_LampLinc142B               14.2B.53  RESP  10100010 group: 01 data: 01 0e 3a
0000 LM1_LampLinc142B               14.2B.53  CTRL  11100010 group: 01 data: 01 0e 3a
0000 KIT1_KitchenSinkLights         1B.3D.90  RESP  10100010 group: 01 data: 01 20 40
0000 KIT1_KitchenSinkLights         1B.3D.90  CTRL  11100010 group: 01 data: 01 20 40
0000 STR_StairsLights               34.76.52  RESP  10100010 group: 01 data: 02 2a 44
0000 STR_StairsLights               34.76.52  CTRL  11100010 group: 01 data: 02 2a 44
0000 OUT6_ManCaveTV                 1B.68.10  RESP  10100010 group: 01 data: 00 00 01
0000 OUT6_ManCaveTV                 1B.68.10  CTRL  11100010 group: 01 data: 02 08 38
0000 KP1_HotTubKeyPad               15.63.AF  RESP  10100010 group: 01 data: 02 0f 36
0000 KP1_HotTubKeyPad               15.63.AF  CTRL  11100010 group: 01 data: 02 0f 36
0000 OUT1_BackYardOutlet            15.97.5A  RESP  10100010 group: 01 data: 02 28 24
0000 OUT1_BackYardOutlet            15.97.5A  CTRL  11100010 group: 01 data: 02 28 24
0000 OFC_OfficeLights               1B.F9.38  RESP  10100010 group: 01 data: 00 00 00
0000 OFC_OfficeLights               1B.F9.38  CTRL  11100010 group: 00 data: 02 16 39
0000 OFC_OfficeLights               1B.F9.38  CTRL  11100010 group: 01 data: 00 00 01
0000 LM6_LampLinc2EB8D0             2E.B8.D0  RESP  10100010 group: 01 data: 01 0e 43
0000 LM6_LampLinc2EB8D0             2E.B8.D0  CTRL  11100010 group: 01 data: 01 0e 43
0000 KP3_MasterKeyPad               15.64.7D  RESP  10100010 group: 01 data: 00 00 00
0000 KP3_MasterKeyPad               15.64.7D  CTRL  11100010 group: 01 data: 02 0f 36
0000 TRC_TrashCansLight             23.FC.A4  RESP  10100010 group: 01 data: 02 2a 43
0000 TRC_TrashCansLight             23.FC.A4  CTRL  11100010 group: 01 data: 02 2a 43
0000 LM5_LampLinc1429               14.29.45  RESP  10100010 group: 01 data: 01 0e 3a
0000 LM5_LampLinc1429               14.29.45  CTRL  11100010 group: 01 data: 01 0e 3a
0000 ADR_AdrianLights               1B.8E.E4  RESP  10100010 group: 01 data: 02 1c 3a
0000 ADR_AdrianLights               1B.8E.E4  CTRL  11100010 group: 01 data: 02 1c 3a
0000 LM4_LampLinc2EB6               2E.B6.18  RESP  10100010 group: 01 data: 01 0e 43
0000 LM4_LampLinc2EB6               2E.B6.18  CTRL  11100010 group: 01 data: 01 0e 43
0000 KP4_FrontKeyPad                24.F0.F1  RESP  10100010 group: 01 data: 02 2c 41
0000 KP4_FrontKeyPad                24.F0.F1  CTRL  11100010 group: 01 data: 02 2c 41
0000 KP2_DeckbKeyPad                13.C3.75  RESP  10100010 group: 01 data: 02 0f 36
0000 KP2_DeckbKeyPad                13.C3.75  CTRL  11100010 group: 01 data: 02 0f 36
0000 MO1_Motion1                    23.17.97  RESP  10100010 group: 01 data: 01 0e 3a
0000 OUT2_FenceOutlet               15.97.4D  RESP  10100010 group: 01 data: 02 08 38
0000 OUT2_FenceOutlet               15.97.4D  CTRL  11100010 group: 01 data: 02 08 38
0000 IOD2_GarageDoor2IO             1C.0C.FD  RESP  10100010 group: 01 data: 07 00 36
0000 IOD2_GarageDoor2IO             1C.0C.FD  CTRL  11100010 group: 01 data: 07 00 36
0000 LM3_LampLinc2EB8A3             2E.B8.A3  RESP  10100010 group: 01 data: 01 0e 43
0000 LM3_LampLinc2EB8A3             2E.B8.A3  CTRL  11100010 group: 01 data: 01 0e 43
0000 KIT2_KitchenLights             25.48.24  RESP  10100010 group: 01 data: 01 20 41
0000 KIT2_KitchenLights             25.48.24  CTRL  11100010 group: 01 data: 01 20 41
0000 FUN_Funtain                    4B.0E.26  RESP  10100010 group: 01 data: 02 2a 45
0000 FUN_Funtain                    4B.0E.26  CTRL  11100010 group: 01 data: 02 2a 45
0000 OUT3_StairsOutlet              57.85.C7  RESP  10100010 group: 01 data: 00 00 01
0000 OUT3_StairsOutlet              57.85.C7  CTRL  11100010 group: 01 data: 02 39 44
0000 GYM_GymLights                  33.F6.43  RESP  10100010 group: 01 data: 02 2a 43
0000 GYM_GymLights                  33.F6.43  CTRL  11100010 group: 01 data: 02 2a 43
0000 LM2_LampLinc2EB4               2E.B4.20  RESP  10100010 group: 01 data: 01 0e 43
0000 LM2_LampLinc2EB4               2E.B4.20  CTRL  11100010 group: 01 data: 01 0e 43
0000 DIN_DiningLights               42.BD.9F  RESP  10100010 group: 01 data: 01 20 45
0000 DIN_DiningLights               42.BD.9F  CTRL  11100010 group: 01 data: 01 20 45
0000 IOD1_GarageDoor1IO             15.BC.41  RESP  10100010 group: 01 data: 07 00 36
0000 IOD1_GarageDoor1IO             15.BC.41  CTRL  11100010 group: 01 data: 07 00 36
0000 OUTA_OutDoor1                  4E.03.28  RESP  10100010 group: 01 data: 02 38 43
0000 OUTA_OutDoor1                  4E.03.28  CTRL  11100010 group: 01 data: 02 38 43
Modem Link DB complete

2023-04-22 09:48:51.533 DEBUG (MainThread) [pyinsteon.messages] RX: msg_id: 0x75, mem_hi: 0x1d, mem_low: 0x88, ack: 0x06
2023-04-22 09:48:51.533 DEBUG (MainThread) [pyinsteon.topics] Topic: ack.read_eeprom data: {'mem_hi': 29, 'mem_low': 136}
2023-04-22 09:48:51.534 DEBUG (MainThread) [pyinsteon.messages] RX: msg_id: 0x59, mem_hi: 0x1d, mem_low: 0x88, flags: {'in use': 0, 'link_mode': 0, 'bit5': 0, 'bit4': 0, 'bit3': 0, 'bit2': 0, 'hwm': 0, 'bit0': 0}, group: 0x00, target: 000000, data1: 0x00, data2: 0x00, data3: 0x00
2023-04-22 09:48:51.534 DEBUG (MainThread) [pyinsteon.000000] RX: msg_id: 0x59, mem_hi: 0x1d, mem_low: 0x88, flags: {'in use': 0, 'link_mode': 0, 'bit5': 0, 'bit4': 0, 'bit3': 0, 'bit2': 0, 'hwm': 0, 'bit0': 0}, group: 0x00, target: 000000, data1: 0x00, data2: 0x00, data3: 0x00
2023-04-22 09:48:51.534 DEBUG (MainThread) [pyinsteon.topics] Topic: read_eeprom_response data: {'mem_addr': 7567, 'flags': {'in use': 0, 'link_mode': 0, 'bit5': 0, 'bit4': 0, 'bit3': 0, 'bit2': 0, 'hwm': 0, 'bit0': 0}, 'group': 0, 'target': 000000, 'data1': 0, 'data2': 0, 'data3': 0}
2023-04-22 09:48:51.534 DEBUG (MainThread) [pyinsteon.000000] Topic: read_eeprom_response data: {'mem_addr': 7567, 'flags': {'in use': 0, 'link_mode': 0, 'bit5': 0, 'bit4': 0, 'bit3': 0, 'bit2': 0, 'hwm': 0, 'bit0': 0}, 'group': 0, 'target': 000000, 'data1': 0, 'data2': 0, 'data3': 0}
2023-04-22 09:48:51.534 DEBUG (MainThread) [pyinsteon.topics] Topic: handler.read_eeprom_response data: {'mem_addr': 7567, 'in_use': False, 'high_water_mark': True, 'controller': False, 'group': 0, 'target': 000000, 'data1': 0, 'data2': 0, 'data3': 0, 'bit5': False, 'bit4': False}
2023-04-22 09:48:51.534 DEBUG (MainThread) [pyinsteon.000000] Topic: handler.read_eeprom_response data: {'mem_addr': 7567, 'in_use': False, 'high_water_mark': True, 'controller': False, 'group': 0, 'target': 000000, 'data1': 0, 'data2': 0, 'data3': 0, 'bit5': False, 'bit4': False}
2023-04-22 09:48:51.535 DEBUG (MainThread) [pyinsteon.topics] Topic: 49fa46.aldb.link_changed data: {'record': {'memory': '0x1d8f', 'control_flags': '0x00', 'group': '0x00', 'target': '00.00.00', 'data1': '0x00', 'data2': '0x00', 'data3': '0x00'}, 'sender': 49fa46, 'deleted': True}
2023-04-22 09:48:51.535 DEBUG (MainThread) [pyinsteon.49fa46] Topic: 49fa46.aldb.link_changed data: {'record': {'memory': '0x1d8f', 'control_flags': '0x00', 'group': '0x00', 'target': '00.00.00', 'data1': '0x00', 'data2': '0x00', 'data3': '0x00'}, 'sender': 49fa46, 'deleted': True}
2023-04-22 09:48:51.535 DEBUG (MainThread) [pyinsteon.aldb.aldb_base] Setting the load status
2023-04-22 09:48:51.535 DEBUG (MainThread) [pyinsteon.aldb.aldb_base] Has First is True
2023-04-22 09:48:51.535 DEBUG (MainThread) [pyinsteon.aldb.aldb_base] Has Last is True
2023-04-22 09:48:51.535 DEBUG (MainThread) [pyinsteon.aldb.aldb_base] Has All is False
2023-04-22 09:48:51.536 DEBUG (MainThread) [pyinsteon.topics] Topic: 49fa46.aldb_status_changed data: {'status': 0x04}
2023-04-22 09:48:51.536 DEBUG (MainThread) [pyinsteon.49fa46] Topic: 49fa46.aldb_status_changed data: {'status': 0x04}
2023-04-22 09:48:51.538 DEBUG (MainThread) [pyinsteon.managers.saved_devices_manager] Writing 38 devices to save file
2023-04-22 09:48:53.539 DEBUG (MainThread) [pyinsteon.aldb.aldb_base] Setting the load status
2023-04-22 09:48:53.539 DEBUG (MainThread) [pyinsteon.aldb.aldb_base] Has First is True
2023-04-22 09:48:53.539 DEBUG (MainThread) [pyinsteon.aldb.aldb_base] Has Last is True
2023-04-22 09:48:53.539 DEBUG (MainThread) [pyinsteon.aldb.aldb_base] Has All is False
2023-04-22 09:48:53.540 DEBUG (MainThread) [pyinsteon.managers.saved_devices_manager] Writing 38 devices to save file

2023-04-22 11:34:25.963 [DEBUG] [ding.insteon.internal.InsteonBinding] - starting to poll /dev/ttyINSTEON
2023-04-22 11:34:25.964 [DEBUG] [binding.insteon.internal.driver.Port] - starting port /dev/ttyINSTEON
2023-04-22 11:34:26.009 [DEBUG] [steon.internal.driver.SerialIOStream] - setting /dev/ttyINSTEON baud rate to 19200
2023-04-22 11:34:26.010 [DEBUG] [steon.internal.driver.SerialIOStream] - successfully opened port /dev/ttyINSTEON
2023-04-22 11:34:26.011 [DEBUG] [binding.insteon.internal.driver.Port] - starting reader...
2023-04-22 11:34:26.011 [DEBUG] [binding.insteon.internal.driver.Port] - starting writer...
2023-04-22 11:34:26.021 [DEBUG] [binding.insteon.internal.driver.Port] - clearing modem db!
2023-04-22 11:34:26.021 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x60|
2023-04-22 11:34:26.038 [DEBUG] [binding.insteon.internal.driver.Port] - found modem 49.FA.46 in device_types: 49.FA.46|broadcastonoff->GroupBroadcastOnOff(0:1:0)
2023-04-22 11:34:26.039 [DEBUG] [binding.insteon.internal.driver.Port] - removed listener from port
2023-04-22 11:34:26.040 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x69|
2023-04-22 11:34:26.069 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:15.64.7D|LinkData1:0x02|LinkData2:0x0F|LinkData3:0x36|
2023-04-22 11:34:26.072 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.102 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:2E.B6.18|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x43|
2023-04-22 11:34:26.102 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.133 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:2E.B6.18|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x43|
2023-04-22 11:34:26.134 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.150 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:15.64.7D|LinkData1:0x02|LinkData2:0x0F|LinkData3:0x36|
2023-04-22 11:34:26.151 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.166 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:2E.B8.A3|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x43|
2023-04-22 11:34:26.166 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.182 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:2E.B8.A3|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x43|
2023-04-22 11:34:26.182 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.213 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:17.96.4A|LinkData1:0x01|LinkData2:0x05|LinkData3:0x2D|
2023-04-22 11:34:26.213 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.245 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:14.2B.53|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x3A|
2023-04-22 11:34:26.246 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.278 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:14.2B.53|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x3A|
2023-04-22 11:34:26.278 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.309 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:23.17.97|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x3A|
2023-04-22 11:34:26.310 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.342 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:1B.8E.E4|LinkData1:0x02|LinkData2:0x1C|LinkData3:0x3A|
2023-04-22 11:34:26.342 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.358 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:1B.8E.E4|LinkData1:0x02|LinkData2:0x1C|LinkData3:0x3A|
2023-04-22 11:34:26.358 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.374 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:23.EA.B1|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x43|
2023-04-22 11:34:26.375 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.405 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:23.EA.B1|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x43|
2023-04-22 11:34:26.406 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.437 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:43.59.F2|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x45|
2023-04-22 11:34:26.438 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.470 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:43.59.F2|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x45|
2023-04-22 11:34:26.470 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.502 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:33.F6.43|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x43|
2023-04-22 11:34:26.503 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.534 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:33.F6.43|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x43|
2023-04-22 11:34:26.534 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.550 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:2E.B4.20|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x43|
2023-04-22 11:34:26.550 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.567 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:2E.B4.20|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x43|
2023-04-22 11:34:26.568 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.583 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:4E.03.28|LinkData1:0x02|LinkData2:0x38|LinkData3:0x43|
2023-04-22 11:34:26.583 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.613 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:4E.03.28|LinkData1:0x02|LinkData2:0x38|LinkData3:0x43|
2023-04-22 11:34:26.614 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.646 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:4D.FF.9D|LinkData1:0x02|LinkData2:0x38|LinkData3:0x43|
2023-04-22 11:34:26.647 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.678 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:4D.FF.9D|LinkData1:0x02|LinkData2:0x38|LinkData3:0x43|
2023-04-22 11:34:26.678 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.709 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:23.FC.A4|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x43|
2023-04-22 11:34:26.709 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.726 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:23.FC.A4|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x43|
2023-04-22 11:34:26.726 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.758 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:1C.0C.FD|LinkData1:0x07|LinkData2:0x00|LinkData3:0x36|
2023-04-22 11:34:26.758 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.773 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:1C.0C.FD|LinkData1:0x07|LinkData2:0x00|LinkData3:0x36|
2023-04-22 11:34:26.774 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.806 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:24.F0.F1|LinkData1:0x02|LinkData2:0x2C|LinkData3:0x41|
2023-04-22 11:34:26.807 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.838 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:24.F0.F1|LinkData1:0x02|LinkData2:0x2C|LinkData3:0x41|
2023-04-22 11:34:26.838 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.869 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:1B.F9.38|LinkData1:0x02|LinkData2:0x16|LinkData3:0x39|
2023-04-22 11:34:26.870 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.901 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:1B.F9.38|LinkData1:0x02|LinkData2:0x16|LinkData3:0x39|
2023-04-22 11:34:26.902 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.934 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:42.BD.9F|LinkData1:0x01|LinkData2:0x20|LinkData3:0x45|
2023-04-22 11:34:26.934 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.950 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:42.BD.9F|LinkData1:0x01|LinkData2:0x20|LinkData3:0x45|
2023-04-22 11:34:26.950 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.966 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:25.4B.F4|LinkData1:0x01|LinkData2:0x20|LinkData3:0x41|
2023-04-22 11:34:26.966 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:26.997 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:25.4B.F4|LinkData1:0x01|LinkData2:0x20|LinkData3:0x41|
2023-04-22 11:34:26.998 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.029 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:25.48.24|LinkData1:0x01|LinkData2:0x20|LinkData3:0x41|
2023-04-22 11:34:27.030 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.061 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:25.48.24|LinkData1:0x01|LinkData2:0x20|LinkData3:0x41|
2023-04-22 11:34:27.062 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.094 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:13.C3.75|LinkData1:0x02|LinkData2:0x0F|LinkData3:0x36|
2023-04-22 11:34:27.094 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:13.C3.75|LinkData1:0x02|LinkData2:0x0F|LinkData3:0x36|
2023-04-22 11:34:27.126 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.158 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:25.45.2D|LinkData1:0x01|LinkData2:0x20|LinkData3:0x41|
2023-04-22 11:34:27.158 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.175 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:25.45.2D|LinkData1:0x01|LinkData2:0x20|LinkData3:0x41|
2023-04-22 11:34:27.175 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.206 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:1B.3D.90|LinkData1:0x01|LinkData2:0x20|LinkData3:0x40|
2023-04-22 11:34:27.206 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.238 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:1B.3D.90|LinkData1:0x01|LinkData2:0x20|LinkData3:0x40|
2023-04-22 11:34:27.238 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.270 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:34.76.52|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x44|
2023-04-22 11:34:27.271 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.302 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:34.76.52|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x44|
2023-04-22 11:34:27.303 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.334 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:14.66.EA|LinkData1:0xFF|LinkData2:0x23|LinkData3:0x01|
2023-04-22 11:34:27.335 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.351 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:1B.68.10|LinkData1:0x02|LinkData2:0x08|LinkData3:0x38|
2023-04-22 11:34:27.352 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.382 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:14.6D.A6|LinkData1:0x02|LinkData2:0x15|LinkData3:0x38|
2023-04-22 11:34:27.382 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.413 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:14.6D.A6|LinkData1:0x02|LinkData2:0x15|LinkData3:0x38|
2023-04-22 11:34:27.414 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.445 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:34.75.1C|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x44|
2023-04-22 11:34:27.446 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.478 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:34.75.1C|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x44|
2023-04-22 11:34:27.478 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.510 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:15.63.AF|LinkData1:0x02|LinkData2:0x0F|LinkData3:0x36|
2023-04-22 11:34:27.511 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.542 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:15.63.AF|LinkData1:0x02|LinkData2:0x0F|LinkData3:0x36|
2023-04-22 11:34:27.543 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.558 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:15.BC.41|LinkData1:0x07|LinkData2:0x00|LinkData3:0x36|
2023-04-22 11:34:27.559 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.574 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:15.BC.41|LinkData1:0x07|LinkData2:0x00|LinkData3:0x36|
2023-04-22 11:34:27.575 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.606 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:2E.B8.D0|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x43|
2023-04-22 11:34:27.606 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.638 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:2E.B8.D0|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x43|
2023-04-22 11:34:27.639 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.670 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:14.29.45|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x3A|
2023-04-22 11:34:27.671 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.702 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:14.29.45|LinkData1:0x01|LinkData2:0x0E|LinkData3:0x3A|
2023-04-22 11:34:27.703 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.734 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:4B.0E.26|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x45|
2023-04-22 11:34:27.735 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.750 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:4B.0E.26|LinkData1:0x02|LinkData2:0x2A|LinkData3:0x45|
2023-04-22 11:34:27.751 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.766 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:57.85.C7|LinkData1:0x02|LinkData2:0x39|LinkData3:0x44|
2023-04-22 11:34:27.767 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.798 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:14.66.EA|LinkData1:0xFF|LinkData2:0x23|LinkData3:0x01|
2023-04-22 11:34:27.798 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.830 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:1B.68.10|LinkData1:0x02|LinkData2:0x08|LinkData3:0x38|
2023-04-22 11:34:27.830 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.861 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:15.97.5A|LinkData1:0x02|LinkData2:0x28|LinkData3:0x24|
2023-04-22 11:34:27.861 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.893 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:15.97.4D|LinkData1:0x02|LinkData2:0x08|LinkData3:0x38|
2023-04-22 11:34:27.894 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.910 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:15.97.5A|LinkData1:0x02|LinkData2:0x28|LinkData3:0x24|
2023-04-22 11:34:27.910 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.926 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:15.97.4D|LinkData1:0x02|LinkData2:0x08|LinkData3:0x38|
2023-04-22 11:34:27.927 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.958 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:57.85.C7|LinkData1:0x02|LinkData2:0x39|LinkData3:0x44|
2023-04-22 11:34:27.958 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:27.989 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x00|LinkAddr:1B.F9.38|LinkData1:0x02|LinkData2:0x16|LinkData3:0x39|
2023-04-22 11:34:27.990 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:28.022 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xE2|ALLLinkGroup:0x01|LinkAddr:41.8D.E2|LinkData1:0xFF|LinkData2:0x1C|LinkData3:0x01|
2023-04-22 11:34:28.022 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:28.054 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:41.8D.E2|LinkData1:0xFF|LinkData2:0x1C|LinkData3:0x01|
2023-04-22 11:34:28.054 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:28.086 [DEBUG] [ding.insteon.internal.InsteonBinding] - got msg: IN:Cmd:0x57|RecordFlags:0xA2|ALLLinkGroup:0x01|LinkAddr:17.96.4A|LinkData1:0x01|LinkData2:0x05|LinkData3:0x2D|
2023-04-22 11:34:28.087 [DEBUG] [binding.insteon.internal.driver.Port] - writing (0): OUT:Cmd:0x6A|
2023-04-22 11:34:28.101 [DEBUG] [steon.internal.device.ModemDBBuilder] - got all link records.
2023-04-22 11:34:28.102 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB ------- start of modem link records ------------------
2023-04-22 11:34:28.102 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 43.59.F2: CTRL group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.102 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 43.59.F2: RESP group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.102 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.103 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 41.8D.E2: CTRL group: 01 data1: FF data2: 1C data3: 1C
2023-04-22 11:34:28.103 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 41.8D.E2: RESP group: 01 data1: FF data2: 1C data3: 1C
2023-04-22 11:34:28.103 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.103 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 25.4B.F4: CTRL group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.104 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 25.4B.F4: RESP group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.104 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.104 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 23.EA.B1: CTRL group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.104 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 23.EA.B1: RESP group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.104 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.105 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 25.45.2D: CTRL group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.105 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 25.45.2D: RESP group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.105 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.105 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 4D.FF.9D: CTRL group: 01 data1: 02 data2: 38 data3: 38
2023-04-22 11:34:28.106 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 4D.FF.9D: RESP group: 01 data1: 02 data2: 38 data3: 38
2023-04-22 11:34:28.106 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.106 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.106 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 17.96.4A: CTRL group: 01 data1: 01 data2: 05 data3: 05
2023-04-22 11:34:28.106 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 17.96.4A: RESP group: 01 data1: 01 data2: 05 data3: 05
2023-04-22 11:34:28.107 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.107 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 14.6D.A6: CTRL group: 01 data1: 02 data2: 15 data3: 15
2023-04-22 11:34:28.107 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 14.6D.A6: RESP group: 01 data1: 02 data2: 15 data3: 15
2023-04-22 11:34:28.107 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.107 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 34.75.1C: CTRL group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.108 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 34.75.1C: RESP group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.108 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.108 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 14.66.EA: RESP group: 01 data1: FF data2: 23 data3: 23
2023-04-22 11:34:28.108 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 14.66.EA: CTRL group: 01 data1: FF data2: 23 data3: 23
2023-04-22 11:34:28.108 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.109 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 14.2B.53: CTRL group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.109 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 14.2B.53: RESP group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.109 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.109 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1B.3D.90: CTRL group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.109 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1B.3D.90: RESP group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.110 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.110 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 34.76.52: CTRL group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.110 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 34.76.52: RESP group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.110 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.111 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1B.68.10: RESP group: 01 data1: 02 data2: 08 data3: 08
2023-04-22 11:34:28.111 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1B.68.10: CTRL group: 01 data1: 02 data2: 08 data3: 08
2023-04-22 11:34:28.111 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.111 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.63.AF: CTRL group: 01 data1: 02 data2: 0F data3: 0F
2023-04-22 11:34:28.112 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.63.AF: RESP group: 01 data1: 02 data2: 0F data3: 0F
2023-04-22 11:34:28.112 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.112 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.97.5A: CTRL group: 01 data1: 02 data2: 28 data3: 28
2023-04-22 11:34:28.112 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.97.5A: RESP group: 01 data1: 02 data2: 28 data3: 28
2023-04-22 11:34:28.112 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.113 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1B.F9.38: CTRL group: 01 data1: 02 data2: 16 data3: 16
2023-04-22 11:34:28.113 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1B.F9.38: RESP group: 01 data1: 02 data2: 16 data3: 16
2023-04-22 11:34:28.113 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1B.F9.38: CTRL group: 00 data1: 02 data2: 16 data3: 16
2023-04-22 11:34:28.113 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.113 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 2E.B8.D0: CTRL group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.114 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 2E.B8.D0: RESP group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.114 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.114 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.64.7D: RESP group: 01 data1: 02 data2: 0F data3: 0F
2023-04-22 11:34:28.114 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.64.7D: CTRL group: 01 data1: 02 data2: 0F data3: 0F
2023-04-22 11:34:28.115 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.115 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 14.29.45: CTRL group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.115 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 14.29.45: RESP group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.115 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.115 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 23.FC.A4: CTRL group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.115 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 23.FC.A4: RESP group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.116 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.116 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1B.8E.E4: CTRL group: 01 data1: 02 data2: 1C data3: 1C
2023-04-22 11:34:28.116 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1B.8E.E4: RESP group: 01 data1: 02 data2: 1C data3: 1C
2023-04-22 11:34:28.116 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.116 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 2E.B6.18: CTRL group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.116 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 2E.B6.18: RESP group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.116 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.117 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 24.F0.F1: CTRL group: 01 data1: 02 data2: 2C data3: 2C
2023-04-22 11:34:28.117 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 24.F0.F1: RESP group: 01 data1: 02 data2: 2C data3: 2C
2023-04-22 11:34:28.117 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.117 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 13.C3.75: CTRL group: 01 data1: 02 data2: 0F data3: 0F
2023-04-22 11:34:28.117 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 13.C3.75: RESP group: 01 data1: 02 data2: 0F data3: 0F
2023-04-22 11:34:28.117 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.118 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 23.17.97: RESP group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.118 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.118 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.97.4D: CTRL group: 01 data1: 02 data2: 08 data3: 08
2023-04-22 11:34:28.118 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.97.4D: RESP group: 01 data1: 02 data2: 08 data3: 08
2023-04-22 11:34:28.118 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.118 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1C.0C.FD: CTRL group: 01 data1: 07 data2: 00 data3: 00
2023-04-22 11:34:28.118 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 1C.0C.FD: RESP group: 01 data1: 07 data2: 00 data3: 00
2023-04-22 11:34:28.119 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.119 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 2E.B8.A3: CTRL group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.119 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 2E.B8.A3: RESP group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.119 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.119 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 25.48.24: CTRL group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.119 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 25.48.24: RESP group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.119 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.120 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 4B.0E.26: CTRL group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.120 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 4B.0E.26: RESP group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.120 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.120 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 57.85.C7: CTRL group: 01 data1: 02 data2: 39 data3: 39
2023-04-22 11:34:28.120 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 57.85.C7: RESP group: 01 data1: 02 data2: 39 data3: 39
2023-04-22 11:34:28.120 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.120 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 33.F6.43: CTRL group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.120 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 33.F6.43: RESP group: 01 data1: 02 data2: 2A data3: 2A
2023-04-22 11:34:28.120 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.121 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 2E.B4.20: CTRL group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.121 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 2E.B4.20: RESP group: 01 data1: 01 data2: 0E data3: 0E
2023-04-22 11:34:28.121 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.121 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 42.BD.9F: CTRL group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.121 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 42.BD.9F: RESP group: 01 data1: 01 data2: 20 data3: 20
2023-04-22 11:34:28.121 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.121 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.BC.41: CTRL group: 01 data1: 07 data2: 00 data3: 00
2023-04-22 11:34:28.121 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 15.BC.41: RESP group: 01 data1: 07 data2: 00 data3: 00
2023-04-22 11:34:28.121 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.122 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 4E.03.28: CTRL group: 01 data1: 02 data2: 38 data3: 38
2023-04-22 11:34:28.122 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB 4E.03.28: RESP group: 01 data1: 02 data2: 38 data3: 38
2023-04-22 11:34:28.122 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB -----
2023-04-22 11:34:28.122 [DEBUG] [steon.internal.device.ModemDBBuilder] - MDB ---------------- end of modem link records -----------
2023-04-22 11:34:28.122 [DEBUG] [binding.insteon.internal.driver.Port] - removed listener from port
2023-04-22 11:34:28.123 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem database has 38 entries!
2023-04-22 11:34:28.123 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 43.59.F2
2023-04-22 11:34:28.123 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 41.8D.E2
2023-04-22 11:34:28.123 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 25.4B.F4
2023-04-22 11:34:28.124 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 23.EA.B1
2023-04-22 11:34:28.124 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 25.45.2D
2023-04-22 11:34:28.124 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 4D.FF.9D
2023-04-22 11:34:28.124 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 49.FA.46
2023-04-22 11:34:28.124 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 17.96.4A
2023-04-22 11:34:28.124 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 14.6D.A6
2023-04-22 11:34:28.124 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 34.75.1C
2023-04-22 11:34:28.124 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 14.66.EA
2023-04-22 11:34:28.124 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 14.2B.53
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 1B.3D.90
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 34.76.52
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 1B.68.10
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 15.63.AF
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 15.97.5A
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 1B.F9.38
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 2E.B8.D0
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 15.64.7D
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 14.29.45
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 23.FC.A4
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 1B.8E.E4
2023-04-22 11:34:28.125 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 2E.B6.18
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 24.F0.F1
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 13.C3.75
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 23.17.97
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 15.97.4D
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 1C.0C.FD
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 2E.B8.A3
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 25.48.24
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 4B.0E.26
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 57.85.C7
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 33.F6.43
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 2E.B4.20
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 42.BD.9F
2023-04-22 11:34:28.126 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 15.BC.41
2023-04-22 11:34:28.127 [DEBUG] [ding.insteon.internal.InsteonBinding] - modem db entry: 4E.03.28
2023-04-22 11:34:28.127 [DEBUG] [ding.insteon.internal.InsteonBinding] - device 43.59.F2 found in the modem database and the plm controls groups (1) and responds to groups (1).
2023-04-22 11:34:28.129 [DEBUG] [nding.insteon.internal.driver.Poller] - start polling device 43.59.F2|fastonoff->FastOnOff(0:1:2)|beep->Beep(0:1:1)|ledbrightness->LEDBrightness(0:1:2)|lastheardfrom->GenericLastTime(1:0:0)|ext_group->ExtStatusGroup(0:0:0)|ledonoff->LEDOnOff(0:1:1)|switch->GenericSwitch(1:1:6)
2023-04-22 11:34:28.129 [DEBUG] [nding.insteon.internal.driver.Poller] - starting poll thread.