openHAB log file numerous ONPLM messages

Hi, Hello and Ho Ho Ho!

Was looking at the openHAB.log file and noticed that every minute or so something related to the PLM is creating an entry.

Is the related to the PLM being polled every 10 minutes?

Is this reading the state of the devices or is it setting them to off?

…set device 00.00.00 to OFF
…set device 00.00.00 to level 0

Does the PLM need to be polled and if so why?

insteonplm.cfg 

    poll_interval=600000 
    #refresh=600000

openhab.log

    2019-12-24 15:15:05.687 [INFO ] [g.insteonplm.InsteonPLMActiveBinding] - devices:  12 configured,  12 polling, msgs received:    24
    2019-12-24 15:15:06.826 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:15:52.981 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:16:39.149 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:17:25.302 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:18:11.459 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:18:57.610 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:19:43.774 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:20:29.927 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:21:16.085 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:22:02.240 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:22:48.394 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:23:34.557 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:25:05.691 [INFO ] [g.insteonplm.InsteonPLMActiveBinding] - devices:  12 configured,  12 polling, msgs received:    12
    2019-12-24 15:25:06.821 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:25:52.989 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:26:39.289 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:27:25.305 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:28:11.462 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:28:57.618 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:29:45.836 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:30:30.440 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:31:16.083 [INFO ] [onplm.internal.device.MessageHandler] - SwitchRequestReplyHandler: set device 00.00.00 to OFF
    2019-12-24 15:32:02.239 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:32:48.393 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:33:34.546 [INFO ] [onplm.internal.device.MessageHandler] - DimmerRequestReplyHandler: set device 00.00.00 to level 0
    2019-12-24 15:35:05.696 [INFO ] [g.insteonplm.InsteonPLMActiveBinding] - devices:  12 configured,  12 polling, msgs received:    12

How many devices do you have? Keep in mind that every device needs to be polled in that interval, not just one.

Hi Tom

12 devices.

Forgive my paranoid obscuration of their address.

Any best practices for polling interval?Not sure why I even need it polled every 10 minutes???

Will see if I can fine tune the logging to only report warning and errors.

Have a look at this topic: openHAB - Filtering event logs

I use it for keeping my log clear of all temp and humidity changes as well as a few other items that are changing all the time.

1 Like

Thanks @H102

Will implement once I figure out exactly what I want and don’t want logged.

For now I used openhab console to set log to WARN for the Insteon PLM binding.

log:set WARN org.openhab.binding.insteonplm

Thanks again.

That part is in the documentation.:grinning:

Filtering the event log is one of those post you come across and bookmark.:wink:

I have mine set to:

 insteonplm:poll_interval=750000

It could probably be longer. Basically what the poll is for is for if the PLM misses a state update when a device is operated manually or maybe you command a scene and don’t take the time to then also postUpdate all of the devices of a scene to their new states and the physical state of a device doesn’t match the OH item’s state. The poll goes and gets the physical state of each device and if the item’s state doesn’t match, it updates it. Outside of the two circumstances I mentioned above, and starting OH fresh, I’m not sure how much this is needed.