search

kuestess / homebridge-platform-insteonlocal

Homebridge platform plugin for local Insteon control
Other
76 stars 26 forks source link

Insteon Plugin for HOOBS box locks up the HOOBS box #288

Open greg-e-ctrl opened 1 year ago

greg-e-ctrl commented 1 year ago

Hi,

When I have the Insteon plugin running and no activity on the Insteon network that I can see in the log, it randomly lockups the entire HOOBS box from communicating with the Insteon hub although the log says it did. My Insteon Director app still works correctly when the Hoobs is in this state.

Also, when I use some of my Insteon physical switches or another program that sends a command it logs that it cannot find that accessory ID but in fact it is in the device list and i can control it from Hoobs when all is working correctly. Here is the log from that: 1/13/2023, 8:55:38 AM Platform Insteonlocal BridgeInsteon LocalMessage is from keypad, filtering non-keypad devices. 1/13/2023, 8:55:38 AM Platform Insteonlocal BridgeInsteon LocalFound 0 accessories matching 418C4B 1/13/2023, 8:55:38 AM Platform Insteonlocal BridgeInsteon LocalHub command: {"standard":{"type":"50","id":"418C4B","gatewayId":"3429F8","extended":false,"messageType":1,"hopsLeft":2,"maxHops":3,"command1":"32","command2":"02","raw":"0250418C4B3429F82B3202"}}

I debugged this with Zac from Hoobs and he said to contact you. I would love to get on the phone with you and share my screen with you. I am a software engineer and know something about all this home iot stuff with the restful apis used, etc. :)

Thanks!

-- Greg

AstonMartin715 commented 1 year ago

I have been running in Debug mode, or at least I thought I was. Here's an example of what it spits out:

Screen Shot 2023-03-19 at 1 08 08 PM
kuestess commented 1 year ago

@AstonMartin715 The extra DEBUG=* in the command above will give debug messages from all of the dependent packages (that manage the connection to the hub) in addition to homebridge.

AstonMartin715 commented 1 year ago

That's the exact command I used (DEBUG=* homebridge -D) . It ran through a bunch of steps and then I just assumed that put it in full debug mode. Is there something else I need to do other than type that command in the terminal window?

By the way, I created an iOS shortcut to turn a lamp on or off using a simple URL that directly communicates with the Insteon Hub. When homebridge stops working so do those shortcuts, supporting my theory that Insteon decides to no longer select commands. When you reboot hoobs or homebridge, it obviously does something to wake Insteon back up and everything works again.

kuestess commented 1 year ago

You should be getting a near constant stream of messages like below. Are you using the docker container?

  home-controller:http making request /buffstatus.xml +202ms
  home-controller:http making request /buffstatus.xml +303ms
  home-controller:http making request /buffstatus.xml +403ms
  home-controller:http making request /buffstatus.xml +502ms
  home-controller:http making request /buffstatus.xml +603ms
  home-controller:http making request /buffstatus.xml +704ms
  home-controller:http making request /buffstatus.xml +803ms
  home-controller:http making request /buffstatus.xml +901ms
  home-controller:http making request /buffstatus.xml +1s
  home-controller:http making request /buffstatus.xml +1s
  home-controller:http making request /buffstatus.xml +1s
  home-controller:http making request /buffstatus.xml +1s
  home-controller:http making request /buffstatus.xml +1s
  home-controller:http making request /buffstatus.xml +2s
  home-controller:http making request /buffstatus.xml +2s
  home-controller:http making request /buffstatus.xml +2s
  home-controller:http making request /buffstatus.xml +2s
  home-controller:http making request /buffstatus.xml +2s
AstonMartin715 commented 1 year ago

No the docker container didn't work on the MAC. Couldn't get to the network. I am using homebridge on a second raspberry pi.

AstonMartin715 commented 1 year ago

Final observation. When the Insteon has stopped accepting commands from either Homebridge or the shortcuts I created, I unplug the Raspberry Pi that is running homebridge, wait a few minutes, and like magic, the shortcuts start to work again. So, the homebridge (and Hoobs) is locking up the Insteon.

greg-e-ctrl commented 1 year ago

Hi @AstonMarton715,

Glad to see you are making progress in identifying the issue!

Here is the URL syntax I use to turn on/off my Insteon dual wall plug by entering the below URLs in any web browser. Similar to the shortcut you made. What URL syntax are you using if I may ask?

The URLs to turn on and off the Insteon wall plug bottom outlet, respectively: http://_username_:_password_@_192.168.10.35_:25105/3?0262_418C4B_0F3202=I=3 http://_username_:_password_@_192.168.10.35_:25105/3?0262_418C4B_0F3302=I=3

Substitute the underlined items above with your username, password, and IP address of your Insteon Hub 2 and the Insteon ID of your wall plug in this case 418C4B.

e-ctrl

On 3/19/2023 1:31 PM, AstonMartin715 wrote:

That's the exact command I used (DEBUG=* homebridge -D) . It ran through a bunch of steps and then I just assumed that put it in full debug mode. Is there something else I need to do other than type that command in the terminal window?

By the way, I created an iOS shortcut to turn a lamp on or off using a simple URL that directly communicates with the Insteon Hub. When homebridge stops working so do those shortcuts, supporting my theory that Insteon decides to no longer select commands. When you reboot hoobs or homebridge, it obviously does something to wake Insteon back up and everything works again.

— Reply to this email directly, view it on GitHub https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1475388769, or unsubscribe https://github.com/notifications/unsubscribe-auth/AMOOUEEEC3DHDPDZH3D6WVDW45UL3ANCNFSM6AAAAAAT264J2Y. You are receiving this because you were mentioned.Message ID: @.***>

AstonMartin715 commented 1 year ago

@greg-e-ctrl that’s the same syntax I am using. Works great until it gets locked up by the bridge as described above.

Curious - you don’t have a UniFi network do you?

greg-e-ctrl commented 1 year ago

No, I am not using a UniFi network.

I am using the standard Comcast provided Xfinity cable modem/WiFi router; white tower rectangular box with slanted top.

e-ctrl

On 3/19/2023 4:29 PM, AstonMartin715 wrote:

@greg-e-ctrl https://github.com/greg-e-ctrl that’s the same syntax I am using. Works great until it gets locked up by the bridge as described above.

Curious - you don’t have a UniFi network do you?

— Reply to this email directly, view it on GitHub https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1475433898, or unsubscribe https://github.com/notifications/unsubscribe-auth/AMOOUECCUO4TGLBYIBCYRETW46JEFANCNFSM6AAAAAAT264J2Y. You are receiving this because you were mentioned.Message ID: @.***>

AstonMartin715 commented 1 year ago

There goes my theory that the router is involved!

@kuestess here is the debug log before a failure:

home-controller:http making request /3?0260=I=3 +1s [19/03/2023, 17:56:27] [InsteonLocal] Connected to Insteon Model 2245 Hub... [19/03/2023, 17:56:27] [InsteonLocal] Getting status for Master Bed Chandelier

And here it is from the same point after a failure:

home-controller:insteon sendCommandTimout - status: {"command":{"raw":"0260","type":"60"},"deferred":{"promise":{}},"timeout":5000,"nakTimeout":10} +5s home-controller:insteon Resend: {"command":{"raw":"0260","type":"60"},"deferred":{"promise":{}},"timeout":5000,"nakTimeout":10} +1ms pi@homebridge:/var/lib/homebridge $

I am now convinced that it's similar to the homeassistant issue I linked to earlier. The Insteon plugin is keeping the network connection to the Insteon hub open and not closing it, preventing any other traffic getting to the hub via the network port (except for traffic from the Director app which I understand takes advantage of a different communication method to avoid 'popcorning').

Oh by the way I can now 100% recreate the non-communication issue within about 1 minute of a reboot by switching on and off a number of devices manually in quick succession. And then to fix the issue I just unplug the Cat5 cable from the Pi (breaking the network connection).

AstonMartin715 commented 1 year ago

@kuestess a netstat -at command is very revealing. It confirms that the homebridge network connection remains open.

@greg-e-ctrl after your connection has seized up, run the network -at command in the terminal window in HOOBS and see if it shows a perpetual open connection at your Hoobs IP address.

kuestess commented 1 year ago

@AstonMartin715 Interesting observation. I tried to run netstat on my machine, but oddly it didn’t see any connection to the hub. I’ll play around with it a little more. nettop is another interesting command.

hypeitinc commented 1 year ago

@kuestess Today the (SLT) System showed "No Response" on the Home App. The MacMini I'm using was unusually warm and logging in I could see that Insteon plugin is restarting every other second or so. I noted that the memory leak warning I have mentioned before is there. No changes had been done to the system. Not sure if this is helpful on this thread or not but here is part of the log:

3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonConnecting to Insteon Model 2245 Hub... 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonConnecting to Insteon Model 2245 Hub... 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonStarted connection watcher... 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonStarted connection watcher... 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Initializing Insteon UI 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Initializing Insteon UI 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Reading config from /var/lib/hoobs/platforminsteonlocalbridge/config.json 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Reading config from /var/lib/hoobs/platforminsteonlocalbridge/config.json 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Found 1 platform(s) in config 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Found 1 platform(s) in config 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Reading devices from insteon.json 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Reading devices from insteon.json 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Done with InsteonUI init 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Done with InsteonUI init 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonFinished initializing platform: Insteon 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonFinished initializing platform: Insteon 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Office Light 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Office Light 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Sconces 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Sconces 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Chandelier 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Chandelier 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Entrance 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Entrance 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Floor Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Floor Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Console Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Console Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Side Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Side Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Back 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Back 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Front 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Front 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Family Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Family Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Living Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Living Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Master 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Master 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Upper Hall 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Upper Hall 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonExecuted didFinishLaunching callback 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonExecuted didFinishLaunching callback 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonFound 13 devices in config 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonFound 13 devices in config 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Office Light 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Office Light 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Sconces 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Sconces 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Chandelier 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Chandelier 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Entrance 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Entrance 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Floor Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Floor Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Console Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Console Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Side Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Side Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Back 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Back 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Front 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Front 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Family Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Family Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Living Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Living Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Master 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Master 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Upper Hall 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Upper Hall 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeSetup URI 'X-HM://0023ISYWYB4AH' 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeSetup URI 'X-HM://0023ISYWYB4AH' 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeShutting down 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeShutting down 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeERROR(node:74971) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 14 connect listeners added to [Insteon]. Use emitter.setMaxListeners() to increase limit 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeERROR(node:74971) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 14 connect listeners added to [Insteon]. Use emitter.setMaxListeners() to increase limit 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeERROR(Use node --trace-warnings ... to show where the warning was created) 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeERROR(Use node --trace-warnings ... to show where the warning was created) 3/23/2023, 4:12:39 PMPlatform Insteonlocal BridgeStopped 3/23/2023, 4:12:39 PMPlatform Insteonlocal BridgeStopped 3/23/2023, 4:12:39 PMPlatform Insteonlocal BridgeERRORNo matching processes were found 3/23/2023, 4:12:39 PMPlatform Insteonlocal BridgeERRORNo matching processes were found 3/23/2023, 4:12:46 PMPlatform Insteonlocal Bridge starting 3/23/2023, 4:12:46 PMPlatform Insteonlocal Bridge starting 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeLoaded plugin 'homebridge-platform-insteonlocal' 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeLoaded plugin 'homebridge-platform-insteonlocal' 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeRegistering platform 'homebridge-platform-insteonlocal.InsteonLocal' 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeRegistering platform 'homebridge-platform-insteonlocal.InsteonLocal' 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeLoading 1 platforms... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeLoading 1 platforms... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonConnecting to Insteon Model 2245 Hub... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonConnecting to Insteon Model 2245 Hub... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonStarted connection watcher... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonStarted connection watcher... 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Initializing Insteon UI 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Initializing Insteon UI 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Reading config from /var/lib/hoobs/platforminsteonlocalbridge/config.json 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Reading config from /var/lib/hoobs/platforminsteonlocalbridge/config.json 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Found 1 platform(s) in config 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Found 1 platform(s) in config 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Reading devices from insteon.json 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Reading devices from insteon.json 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Done with InsteonUI init 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Done with InsteonUI init 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonFinished initializing platform: Insteon 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonFinished initializing platform: Insteon 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Office Light 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Office Light 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Sconces 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Sconces 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Chandelier 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Chandelier 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Entrance 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Entrance 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Floor Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Floor Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Console Table Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Console Table Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Side Table Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Side Table Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Back 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Back 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Front 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Front 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Family Room 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Family Room 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Living Room 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Living Room 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Master 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Master 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Upper Hall 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Upper Hall 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonExecuted didFinishLaunching callback 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonExecuted didFinishLaunching callback 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonFound 13 devices in config 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonFound 13 devices in config 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Office Light 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Office Light 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Sconces 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Sconces 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Chandelier 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Chandelier 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Entrance 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Entrance 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Floor Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Floor Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Console Table Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Console Table Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Side Table Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Side Table Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Back 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Back 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Front 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Front 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Family Room 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Family Room 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Living Room 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Living Room 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Master 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Master 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Upper Hall 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Upper Hall 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeSetup URI 'X-HM://0023ISYWYB4AH' 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeSetup URI 'X-HM://0023ISYWYB4AH' 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeShutting down 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeShutting down 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeERROR(node:74990) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 14 connect listeners added to [Insteon]. Use emitter.setMaxListeners() to increase limit 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeERROR(node:74990) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 14 connect listeners added to [Insteon]. Use emitter.setMaxListeners() to increase limit 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeERROR(Use node --trace-warnings ... to show where the warning was created) 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeERROR(Use node --trace-warnings ... to show where the warning was created) 3/23/2023, 4:12:51 PMPlatform Insteonlocal BridgeStopped 3/23/2023, 4:12:51 PMPlatform Insteonlocal BridgeStopped

kuestess commented 1 year ago

@hypeitinc That looks like something different - do you somehow have two instances of homebridge running? (notice duplicate lines for each message)

@AstonMartin715 I did a little homework on your observation above using iftop as I couldn't get netstat to show my connection to the hub. The underlying home-controller package manages connections to the hub and I think the remaining connection you're seeing is a result of how that code and the node http module handles connections. From what I can glean, it only keeps one active connection to the hub at a time, but a pool of TCP sockets that the http code holds on to and rotates through. When you run netstat or another network tool, you can see those sockets, however they are inactive. I can confirm this with iftop as it shows throughput for each socket in the pool - all are inactive except for one at a a time. The command I ran was sudo iftop -i en0 -o destination -f "host <IP address of hub>". You can install iftop using brew on a Mac.

Interestingly enough, I was able to get my hub to a state that you are describing. I let homebridge run for a couple days and eventually I couldn't reconnect to the hub. Even restarting homebridge didn't work, but the Insteon app did work (albeit slow response). Once I unplugged/replugged the hub, all worked as expected, which leads me to believe that this is a hub issue.

sabresoftware2021 commented 1 year ago

@greg-e-ctrl I meant to power cycle your Hub. Sometimes they get a bit wonky, and unfortunately no way to reboot them without unplugging. 'Spin up' is nerd speak :-) for setting up a docker container to run/administrate home bridge. See here: https://github.com/oznu/homebridge-config-ui-x

I have my Raspberry Pi HomeBridge hub plugged into an Eve power bar (WIFI connected with each outlet individually controllable) allowing me to remotely restart the HomeBridge hub, via HomeKit or Siri command.

AstonMartin715 commented 1 year ago

Interestingly enough, I was able to get my hub to a state that you are describing. I let homebridge run for a couple days and eventually I couldn't reconnect to the hub. Even restarting homebridge didn't work, but the Insteon app did work (albeit slow response). Once I unplugged/replugged the hub, all worked as expected, which leads me to believe that this is a hub issue.

@kuestess you don't even need to reboot the hub. Simply removing the ethernet cable, waiting and plugging it back in solves the problem (for me at least). If I had a device that could periodically shut down the connection between the Pi and the switch that would probably solve my problem. Is that a line of code you could add? Like keep-alive but frequently close the open port? One thing to test, when your Insteon app works but the hub doesn't. Try to send an http command to the Insteon hub (see exchange between me and @greg-e-ctrl above) - I bet it doesn't accept them.

sabresoftware2021 commented 1 year ago

I looked at one device as follows:

Insteon bulb

  1. Turned on with Insteon remote switch (battery operated)

    • Insteon Director shows bulb off
    • HomeKit shows bulb off
    • Alexa shows bulb off
    • Insteon app on refresh (toggle between favourites and devices screen) shows bulb as on, and then Director shows bulb on. Refresh of Alexa screen then also shows bulb on

  2. Turned on with Insteon app

    • HomeKit shows as off
    • Director shows as on
    • Alexa shows as on

  3. Turned on with Alexa

    • HomeKit shows as off
    • Director shows as on
    • Insteon app shows as on

  4. Turned on with Director

    • HomeKit shows as off
    • Alexa shows as on
    • Insteon app shows as off

  5. Turned on with HomeKit

    • Director shows as on
    • Alexa shows as on
    • Insteon app shows as on

In all cases the bulb turned on. This was with both refresh and keepActive set to 0. With keepActive set to 3600 and refresh to 0 there was no real change, except that when turned on with HomeKit, Director did not show as on, Alexa did not show as on, but Insteon app did show as on, and then after accessing the Insteon app both Director and Alexa now showed as on.

The only way to get HomeKit to show as on when the light was switched on with any method other than HomeKit was to set a short refresh rate, which makes for a lot of network traffic.

I am convinced that most of the problem originated with the Insteon hub not sending status updates when a device state changes.

greg-e-ctrl commented 1 year ago

Hi Folks!

Haven't seen/heard much activity on this topic lately... where are we with resolving this issue?

Thanks!

e-ctrl

On 3/23/2023 4:24 PM, Peter Rexelius wrote:

@kuestess https://github.com/kuestess Today the (SLT) System showed "No Response" on the Home App. The MacMini I'm using was unusually warm and logging in I could see that Insteon plugin is restarting every other second or so. I noted that the memory leak warning I have mentioned before is there. No changes had been done to the system. Not sure if this is helpful on this thread or not but here is part of the log:

3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonConnecting to Insteon Model 2245 Hub... 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonConnecting to Insteon Model 2245 Hub... 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonStarted connection watcher... 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonStarted connection watcher... 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Initializing Insteon UI 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Initializing Insteon UI 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Reading config from /var/lib/hoobs/platforminsteonlocalbridge/config.json 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Reading config from /var/lib/hoobs/platforminsteonlocalbridge/config.json 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Found 1 platform(s) in config 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Found 1 platform(s) in config 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Reading devices from insteon.json 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Reading devices from insteon.json 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Done with InsteonUI init 3/23/2023, 4:12:37 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:37 PM] [InsteonUI] Done with InsteonUI init 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonFinished initializing platform: Insteon 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonFinished initializing platform: Insteon 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Office Light 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Office Light 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Sconces 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Sconces 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Chandelier 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Chandelier 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Entrance 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Entrance 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Floor Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Floor Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Console Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Console Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Side Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Side Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Back 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Back 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Front 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Front 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Family Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Family Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Living Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Living Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Master 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Master 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Upper Hall 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Upper Hall 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonExecuted didFinishLaunching callback 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonExecuted didFinishLaunching callback 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonFound 13 devices in config 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonFound 13 devices in config 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Office Light 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Office Light 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Sconces 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Sconces 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Chandelier 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Chandelier 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Entrance 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Entrance 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Floor Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Floor Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Console Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Console Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Side Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Side Table Lamp 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Back 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Back 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Front 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Front 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Family Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Family Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Living Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Living Room 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Master 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Master 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Upper Hall 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Upper Hall 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeSetup URI 'X-HM://0023ISYWYB4AH' 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeSetup URI 'X-HM://0023ISYWYB4AH' 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeShutting down 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeShutting down 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeERROR(node:74971) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 14 connect listeners added to [Insteon]. Use emitter.setMaxListeners() to increase limit 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeERROR(node:74971) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 14 connect listeners added to [Insteon]. Use emitter.setMaxListeners() to increase limit 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeERROR(Use |node --trace-warnings ...| to show where the warning was created) 3/23/2023, 4:12:37 PMPlatform Insteonlocal BridgeERROR(Use |node --trace-warnings ...| to show where the warning was created) 3/23/2023, 4:12:39 PMPlatform Insteonlocal BridgeStopped 3/23/2023, 4:12:39 PMPlatform Insteonlocal BridgeStopped 3/23/2023, 4:12:39 PMPlatform Insteonlocal BridgeERRORNo matching processes were found 3/23/2023, 4:12:39 PMPlatform Insteonlocal BridgeERRORNo matching processes were found 3/23/2023, 4:12:46 PMPlatform Insteonlocal Bridge starting 3/23/2023, 4:12:46 PMPlatform Insteonlocal Bridge starting 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeLoaded plugin 'homebridge-platform-insteonlocal' 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeLoaded plugin 'homebridge-platform-insteonlocal' 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeRegistering platform 'homebridge-platform-insteonlocal.InsteonLocal' 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeRegistering platform 'homebridge-platform-insteonlocal.InsteonLocal' 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeLoading 1 platforms... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeLoading 1 platforms... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonConnecting to Insteon Model 2245 Hub... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonConnecting to Insteon Model 2245 Hub... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonStarted connection watcher... 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonStarted connection watcher... 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Initializing Insteon UI 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Initializing Insteon UI 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Reading config from /var/lib/hoobs/platforminsteonlocalbridge/config.json 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Reading config from /var/lib/hoobs/platforminsteonlocalbridge/config.json 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Found 1 platform(s) in config 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Found 1 platform(s) in config 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Reading devices from insteon.json 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Reading devices from insteon.json 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Done with InsteonUI init 3/23/2023, 4:12:48 PMPlatform Insteonlocal Bridge[3/23/2023, 4:12:48 PM] [InsteonUI] Done with InsteonUI init 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonFinished initializing platform: Insteon 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonFinished initializing platform: Insteon 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Office Light 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Office Light 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Sconces 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Sconces 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Chandelier 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Living Room Chandelier 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Entrance 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Entrance 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Floor Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Floor Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Console Table Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Console Table Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Side Table Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Side Table Lamp 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Back 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Back 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Front 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Gutter Front 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Family Room 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Family Room 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Living Room 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Living Room 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Master 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Master 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Upper Hall 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonLoading accessory from cache: Temp Upper Hall 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonExecuted didFinishLaunching callback 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonExecuted didFinishLaunching callback 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonFound 13 devices in config 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonFound 13 devices in config 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Office Light 3/23/2023, 4:12:48 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Office Light 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Sconces 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Sconces 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Chandelier 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Living Room Chandelier 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Entrance 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Entrance 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Floor Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Floor Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Console Table Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Console Table Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Side Table Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Side Table Lamp 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Back 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Back 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Front 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Gutter Front 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Family Room 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Family Room 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Living Room 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Living Room 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Master 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Master 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Upper Hall 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeInsteonRestoring existing accessory from cache: Temp Upper Hall 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeSetup URI 'X-HM://0023ISYWYB4AH' 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeSetup URI 'X-HM://0023ISYWYB4AH' 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeShutting down 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeShutting down 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeERROR(node:74990) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 14 connect listeners added to [Insteon]. Use emitter.setMaxListeners() to increase limit 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeERROR(node:74990) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 14 connect listeners added to [Insteon]. Use emitter.setMaxListeners() to increase limit 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeERROR(Use |node --trace-warnings ...| to show where the warning was created) 3/23/2023, 4:12:49 PMPlatform Insteonlocal BridgeERROR(Use |node --trace-warnings ...| to show where the warning was created) 3/23/2023, 4:12:51 PMPlatform Insteonlocal BridgeStopped 3/23/2023, 4:12:51 PMPlatform Insteonlocal BridgeStopped

— Reply to this email directly, view it on GitHub https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1482040377, or unsubscribe https://github.com/notifications/unsubscribe-auth/AMOOUECDABHUX4ISCBCCIQDW5TLSVANCNFSM6AAAAAAT264J2Y. You are receiving this because you were mentioned.Message ID: @.***>

AstonMartin715 commented 1 year ago

I remain convinced from my extensive testing that the plugin is leaving the connection to the Insteon hub open. It needs code to shut that down after communication. Until then, this will persist. I know this view isn't shared by @kuestess. But remember I have now tested homebridge, hoobs, 2 different RaspberryPI computers, and 2 different Insteon hubs. The only common factors are (1) the Insteon plugin and (2) my home and network setup. On (1), remember I also tested a different plugin (non-Insteon) and it worked. On (2) I will be testing the setup on a different home and network as soon as I can.

sabresoftware2021 commented 1 year ago

I think that the Insteon hub is the culprit. I find that even the new Director app is not properly updated when devices change state. The old Insteon app generally shows the correct status, but often the app has to be refreshed (by swapping from Favorites to Devices screen or visa versa).

AstonMartin715 commented 1 year ago

I disagree. The Insteon hub has been a workhorse for me for years, and I have 3 or them. Very reliable. The newer Director app may be buggy though.

greg-e-ctrl commented 1 year ago

I disagree as well. It is NOT the Insteon Hub. Mine has been running for years with no issues whatsoever; it has been one of the most solid, robust consumer devices I have every purchased.

And I agree 100% with @AstonMartin715's analysis that it IS an issue with the HOOBS box/plugin combo. And Thank You for doing all this testing!!!

@@.***: Are you listening? Can you please fix this?

Thanks and Happy Easter!

e-ctrl

On 4/6/2023 3:09 PM, AstonMartin715 wrote:

I disagree. The Insteon hub has been a workhorse for me for years, and I have 3 or them. Very reliable. The newer Director app may be buggy though.

— Reply to this email directly, view it on GitHub https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1499685179, or unsubscribe https://github.com/notifications/unsubscribe-auth/AMOOUEDE2YPOILFGFHGFXCLW745KZANCNFSM6AAAAAAT264J2Y. You are receiving this because you were mentioned.Message ID: @.***>

zzack01 commented 1 year ago

I agree with @kuestess, I believe this is the insteon hub issue:** https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1483853318

I think if it were a HOOBS™ issue then the almost thousand people from discord would all be reporting the same, I too use a HOOBS™ box and do not have this issue.

I think if it were a plugin issue, thousands of users would be reporting this issue, again I too use this plugin without this issue.

I have also reached out to pass people that I have helped set up the insteon plugin and they report everything is working.

There was only @greg-e-ctrl @AstonMartin715 @mightstricky that is running HOOBS™ with this issue There are also @hypeitinc using a mac mini with this issue Also @sabresoftware2021 @AstonMartin715 used homebridge on a pi and had this issue https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1499661229

Again it may be possible you all share a setting with vpn/firewall/router setting... but I think we ruled that out earlier

Since it is across so many devices & platforms and it seems like none of the networks are the same, the only thing that all shares is the insteon hub...

greg-e-ctrl commented 1 year ago

I hear you @Zach and thanks for replying, but think of attacking this from our perspective below:

If what you say is true, then why has my hub been working flawlessly for over 5+ years with the OG Insteon app and also with the newly released Insteon Director app? BTW, I never have had to reboot my Insteon hub for any reason as it has never locked up.

And why ONLY when I introduce/turn on the HOOBS box with the Insteon plugin running in it does the HOOBS box stop working after a few hours? A quick reboot of the HOOBS box fixes the issue instantly or if you unplug the ethernet cable and wait an hour or so until it times-out and resets. But then in the next few hours it just locks up again. NO INTERACTION whatsoever is required with the Insteon Hub in order to resolve this.

Even if there may be some other setting/config/device common in our networks causing the same issue, then that would certainly be interesting to find our how to determine this? Perhaps a network sniffer like Wireshark may help?

So all we are asking is to do this reset periodically in software so we no not have to manually reboot them.

Thanks for listening!

e-ctrl

On 4/7/2023 10:02 AM, zzack01 wrote:

I agree with @kuestess https://github.com/kuestess, I believe this is the insteon hub issue:**

288 (comment)

https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1483853318

I think if it were a HOOBS™ issue then the almost thousand people from discord would all be reporting the same, I too use a HOOBS™ box and do not have this issue.

I think if it were a plugin issue, thousands of users would be reporting this issue, again I too use this plugin without this issue.

I have also reached out to pass people that I have helped set up the insteon plugin and they report everything is working.

There was only @greg-e-ctrl https://github.com/greg-e-ctrl @AstonMartin715 https://github.com/AstonMartin715 @mightstricky https://github.com/mightstricky that is running HOOBS™ with this issue There are also @hypeitinc https://github.com/hypeitinc using a mac mini with this issue Also @sabresoftware2021 https://github.com/sabresoftware2021 @AstonMartin715 https://github.com/AstonMartin715 used homebridge on a pi and had this issue

288 (comment)

https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1499661229

Again it may be possible you all share a setting with vpn/firewall/router setting... but I think we ruled that out earlier

Since it is across so many devices & platforms and it seems like none of the networks are the same, the only thing that all shares is the insteon hub...

— Reply to this email directly, view it on GitHub https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1500466698, or unsubscribe https://github.com/notifications/unsubscribe-auth/AMOOUEHZIAD6RVY2YJZBPIDXABCDPANCNFSM6AAAAAAT264J2Y. You are receiving this because you were mentioned.Message ID: @.***>

AstonMartin715 commented 1 year ago

One more data point to add to @greg-e-ctrl. The Insteon hub flawlessly accepts http commands, and has done for me for years, from any device. For example, I've been using irule to control lights since 2015. Up until the network issue caused by this setup when even that gets locked out. And don't forget I've used 2 Insteon hubs with this setup and both fail the same way. If your assertions are correct @zzack01 this would be a massively unfortunate coincidence that I have to have 2 of the bad ones.

AstonMartin715 commented 1 year ago

If anyone wants to send me an insteon hub that they know for sure works with hoobs I’m happy to test it.

greg-e-ctrl commented 1 year ago

Agreed!

I too have a program i wrote in C that has been running for years on my home server. It reads my power meter and if my solar is pushing to the grid it will turn on an Insteon power outlet that my EV car charger is plugged into; otherwise turn it off. I use the same HTTP commands to turn it on/off as AstonMartin715 mentions, and we both shared earlier on this thread. When i start getting errors texted to me from my program that it cannot turn on/off the Insteon outlet, then i know the HOOBS box has gone south...

So until this is fixed my HOOBS box is just a paper weight as I need to guarantee my program continues to work as it has for many years and that I will have a fully charged EV car when needed! :(

BTW, has anyone approached Insteon for help on this? Their new fearless leader Ken seems open to most things... :)

Thanks for keep digging!

e-ctrl

On 4/7/2023 12:23 PM, AstonMartin715 wrote:

One more data point to add to @greg-e-ctrl https://github.com/greg-e-ctrl. The Insteon hub flawlessly accepts http commands, and has done for me for years, from any device. For example, I've been using irule to control lights since 2015. Up until the network issue caused by this setup when even that gets locked out. And don't forget I've used 2 Insteon hubs with this setup and both fail the same way. If your assertions are correct @zzack01 https://github.com/zzack01 this would be a massively unfortunate coincidence that I have to have 2 of the bad ones.

— Reply to this email directly, view it on GitHub https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1500573199, or unsubscribe https://github.com/notifications/unsubscribe-auth/AMOOUEA7QS7RCNBIFIZMKXTXABSUZANCNFSM6AAAAAAT264J2Y. You are receiving this because you were mentioned.Message ID: @.***>

greg-e-ctrl commented 1 year ago

Great idea! That would seem to eliminate the very remote theory that certain Insteon boxes behave differently in the same network environment.

Thanks for volunteering to test this @AstonMartin715!

Can someone @.***?) please offer up an Insteon box, that does not experience this behavior, to loan to @AstonMartin715 ASAP so they can carry out this experiment?

Thanks again!

e-ctrl

On 4/7/2023 12:52 PM, AstonMartin715 wrote:

If anyone wants to send me an insteon hub that they know for sure works with hoobs I’m happy to test it.

— Reply to this email directly, view it on GitHub https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1500592345, or unsubscribe https://github.com/notifications/unsubscribe-auth/AMOOUEDLN42V7HM27W6BK6TXABV6BANCNFSM6AAAAAAT264J2Y. You are receiving this because you were mentioned.Message ID: @.***>

hypeitinc commented 1 year ago

@zzack01 The one thing that is also common is the Hoobs software and the Insteonlocal software. Forget the hardware they run on.

Instead of bitching on who’s fault it is, it might be better to come up with way of troubleshooting this.

Personally, I have made a decision to rip out all Insteon devices and change to a WiFi/HomeKit enabled solution as I have seen other reliability issues with the Insteon products. I have not had any problems, so far with any of the HomeKit products I have been testing now for more than a year. Life is too precious to spend time on fiddling on this not being able to rely on having remote control 24/7.

/Peter

On Apr 7, 2023, at 10:02 AM, zzack01 @.***> wrote:

I agree with @kuestess https://github.com/kuestess, I believe this is the insteon hub issue:**

288 (comment) https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1483853318

I think if it were a HOOBS™ issue then the almost thousand people from discord would all be reporting the same, I too use a HOOBS™ box and do not have this issue.

I think if it were a plugin issue, thousands of users would be reporting this issue, again I too use this plugin without this issue.

I have also reached out to pass people that I have helped set up the insteon plugin and they report everything is working.

There was only @greg-e-ctrl https://github.com/greg-e-ctrl @AstonMartin715 https://github.com/AstonMartin715 @mightstricky https://github.com/mightstricky that is running HOOBS™ with this issue There are also @hypeitinc https://github.com/hypeitinc using a mac mini with this issue Also @sabresoftware2021 https://github.com/sabresoftware2021 @AstonMartin715 https://github.com/AstonMartin715 used homebridge on a pi and had this issue

288 (comment) https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1499661229

Again it may be possible you all share a setting with vpn/firewall/router setting... but I think we ruled that out earlier

Since it is across so many devices & platforms and it seems like none of the networks are the same, the only thing that all shares is the insteon hub...

— Reply to this email directly, view it on GitHub https://github.com/kuestess/homebridge-platform-insteonlocal/issues/288#issuecomment-1500466698, or unsubscribe https://github.com/notifications/unsubscribe-auth/AASSOQR4QOFVIJBAEA4GUULXABCDNANCNFSM6AAAAAAT264J2Y. You are receiving this because you were mentioned.

mightstricky commented 1 year ago

I was one of the first ones to be involved in this thread. I have been silent for a while but Peter/Hyperion a comment above resonated with me because that’s exactly how I felt when I went silent. Let me reiterate and go silent again.

HOOBS and Insteonlocal need to stop bitching about this and work together to solve this problem.

In the meantime, I too have replaced 99% of my Insteon devices with HomeKit enables Wi-Fi devices. I made sure none of the replacement requires a hub because HomeKit devices has been very stable without a hub. The only device I have yet to find a replacement for is the 0-5V Ballast Dimmer from Insteon that I use to control an HVAC booster fan. Everything else Insteon is gone and will hit eBay soon.

Good luck everyone who is continuing with HOOBS and Insteonlocal. I sincerely hope this gets resolved for all of you.

zzack01 commented 1 year ago

Hey guys, Im a not try to blame fault, I am looking at the facts of the entire thread and see people using both homebridge and HOOBS™ having the same issue. I see people using different hardware then the HOOBS™ box having the issue. Which leads to believe that the HOOBS™ box and the HOOBS™ software alone is not the issue.

If you are using HOOBS™ and would like a new operating system please follow the steps on the website below: https://support.hoobs.org/topics/resetting-re-flashing/how-to-i-re-flash-the-software

@AstonMartin715 shared that you have this issue on HOOBS™ and homebridge. So on both the similarities are the plugin, the network, and the insteon system. PLUGIN: @kuestess if a user is already using another program with insteon will this have any affect/interference of your plugin? NETWORK: We've been through the network (no firewall/vpn/... maybe ensure WMM NO-ack, Smart connect, 802.11ax WiFi6 mode, airtime fairness firewall, smart connect, mac filter,...) Also try changing the encrypt method to WPA2 only, change the channel band to 1 or 6 or 11, change the IP of DNS server to 8.8.8.8. Could also reset the router to factory or use network of another router, then check if the problem could be solved. INSTEON: Have you tried to factory reset the insteon hub? Then maybe add a single light switch and then run a new insteon plugin to see if you are having the same affect.

@greg-e-ctrl have you tried running only homebridge to see if the issue is the same? Also try the above too.

@kuestess do you have any other ideas? I am out of ideas to try...

AstonMartin715 commented 1 year ago

INSTEON: Have you tried to factory reset the insteon hub? Then maybe add a single light switch and then run a new insteon plugin to see if you are having the same affect.

Yes did exactly that. Same issue.

kuestess commented 1 year ago

Hi all, finally had a little time to dig into this again - ran Wireshark alongside the plugin, and watched that happened with the connection. Let it run for a while, but was never able to get it to a state where the hub wasn't responding. @AstonMartin715 or @greg-e-ctrl are either of you able to run Wireshark and watch the traffic between your hub and the homebridge machine?