Open isaac-the-newt opened 2 years ago
Hi @isaac-the-newt, these errors point to a newly introduced feature
Hi Matthias,
Thanks for this information.
I’m no developer but can see the intention of this watchdog code section.
The HUE Bridge and the Node-RED instance are on a LAN with gigabit connectivity and sub-millisecond transit so I can see no reason for networking issues to be the cause of the bridge reconnecting as shown in the log file. The bridge has the latest firmware and all other related software entities are at the latest release. The bridge node has no new (additional) configuration options (like an adjustment for the watchdog timeout) so it’s a mystery to me. I might increase the verbosity of the logs to see if any other related messages (trace and debug) might prove helpful.
Thanks again.
regards,
Greg Belcher
From: Matthias @.> Sent: Tuesday, 22 March 2022 08:56 To: Foddy/node-red-contrib-huemagic @.> Cc: isaac-the-newt @.>; Mention @.> Subject: Re: [Foddy/node-red-contrib-huemagic] TypeError: Cannot read properties of undefined (reading 'apply') (Issue #344)
Hi @isaac-the-newt https://github.com/isaac-the-newt , these errors point to a newly introduced feature
— Reply to this email directly, https://github.com/Foddy/node-red-contrib-huemagic/issues/344#issuecomment-1074459935 view it on GitHub, or https://github.com/notifications/unsubscribe-auth/AWY7QE2YDN535MR4GRBW2QTVBDWABANCNFSM5RG4MMHA unsubscribe. You are receiving this because you were mentioned. https://github.com/notifications/beacon/AWY7QE334UTQKLJAFLQQLE3VBDWABA5CNFSM5RG4MMHKYY3PNVWWK3TUL52HS4DFVREXG43VMVBW63LNMVXHJKTDN5WW2ZLOORPWSZGOIAFPKHY.gif Message ID: @.***>
Hi Foddy,
I've updated to version 4.2.2 and the spamming of the log file has stopped (on INFO level logging). The occurrence of the "TypeError: Cannot read properties of undefined (reading 'apply')" error message has diminished in frequency but I was able to see it once while testing via toggling many lights in cycles (not a normal use case). I'll keep monitoring and provide a further update one way or the other within the next week. Thanks for your support of this project.
Hi Foddy,
I didn't let the logs accumulate long enough .... Every two minutes a cycle of errors with reconnects ....
24 Mar 12:55:26 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 12:55:26 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 12:55:40 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 12:55:40 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 12:55:40 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 12:55:41 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 12:55:41 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 12:55:41 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 12:55:41 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 12:55:45 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 12:55:45 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 12:55:45 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 12:55:46 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 12:55:46 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 12:55:47 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 12:55:47 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 12:57:22 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 12:57:22 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 12:57:22 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 12:57:23 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 12:57:23 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 12:57:24 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 12:57:24 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 12:57:53 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 12:57:53 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 12:57:53 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 12:57:54 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 12:57:54 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 12:57:54 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 12:57:54 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 12:59:45 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 12:59:45 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 12:59:46 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 12:59:47 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 12:59:47 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 12:59:47 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 12:59:47 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 13:00:16 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 13:00:16 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 13:00:16 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 13:00:17 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 13:00:17 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 13:00:18 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 13:00:18 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 13:02:29 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 13:02:29 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 13:02:29 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 13:02:29 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 13:02:30 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 13:02:30 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 13:02:31 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 13:02:31 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 13:02:31 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 13:02:31 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 13:02:31 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 13:02:31 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 13:02:32 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 13:02:32 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 13:03:02 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 13:03:02 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 13:03:02 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 13:03:03 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 13:03:03 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 13:03:03 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 13:03:03 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 13:03:23 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 13:03:23 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 13:03:23 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 13:03:23 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 13:03:23 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 13:03:23 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 13:03:24 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 13:03:24 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 13:03:24 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 13:03:24 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 13:03:24 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 13:03:24 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 13:03:24 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 13:03:25 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 13:03:25 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 13:03:25 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 13:03:25 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 13:03:25 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 13:03:25 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 13:03:26 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 13:03:26 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 13:04:02 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 13:04:02 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 13:04:02 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 13:04:02 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 13:04:02 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 13:04:03 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 13:04:03 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 24 Mar 13:05:17 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 24 Mar 13:05:17 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 24 Mar 13:05:17 - [info] [hue-bridge:Philips hue] Connected to bridge 24 Mar 13:05:18 - [info] [hue-bridge:Philips hue] Processing bridge resources… 24 Mar 13:05:18 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 24 Mar 13:05:19 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 24 Mar 13:05:19 - [info] [hue-bridge:Philips hue] Subscribing to bridge events…
Node-Red running as a Home Assistant add-on Add-on version: 11.1.0 You are running the latest version of this add-on. System: Home Assistant OS 7.5 (amd64 / qemux86-64) Home Assistant Core: 2022.3.5 Home Assistant Supervisor: 2022.03.5
Please, share the above information when looking for help or support in, e.g., GitHub, forums or the Discord chat.
21 Mar 18:59:18 - [info] Node-RED version: v2.2.2 21 Mar 18:59:18 - [info] Node.js version: v16.14.0 21 Mar 18:59:18 - [info] Linux 5.10.103 x64 LE
==================================
Version 4.2.0 of HUEMagic appears to have introduced another error when commanding the lights.... TypeError: Cannot read properties of undefined (reading 'apply') As well, the bridge is reconnecting continually spamming the log file (log set to INFO level logging).
21 Mar 11:00:38 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:00:38 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:00:38 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:00:39 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:00:39 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:00:39 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:00:39 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:00:39 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:00:40 - [info] [hue-bridge:Philips hue] [object Object] 21 Mar 11:00:40 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:00:40 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:00:40 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:00:40 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:00:41 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:00:41 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:00:41 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:00:41 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:00:49 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:00:49 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:00:49 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:00:49 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:00:49 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:00:49 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:00:50 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:00:50 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:00:50 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:00:50 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:00:51 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:00:51 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:00:51 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:00:51 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:00:59 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:00:59 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:00:59 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:01:00 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:01:00 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:01:01 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:01:01 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:01:10 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:01:10 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:01:10 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:01:10 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:01:10 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:01:11 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:01:11 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:01:11 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:01:11 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:01:12 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:01:12 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:01:12 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:01:12 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:01:12 - [error] [hue-light:Dining Table 1] TypeError: Cannot read properties of undefined (reading 'apply') 21 Mar 11:01:12 - [error] [hue-light:Kitchen Bench] TypeError: Cannot read properties of undefined (reading 'apply') 21 Mar 11:01:12 - [error] [hue-light:Backroom] TypeError: Cannot read properties of undefined (reading 'apply') 21 Mar 11:01:12 - [error] [hue-light:Dining Table 2] TypeError: Cannot read properties of undefined (reading 'apply') 21 Mar 11:01:20 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:01:20 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:01:20 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:01:20 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:01:20 - [info] [hue-bridge:Philips hue] Error: Request failed with status code 503 21 Mar 11:01:21 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:01:22 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:01:22 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:01:22 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:01:22 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:01:30 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:01:30 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:01:30 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:01:32 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:01:32 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:01:32 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:01:32 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:01:51 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:01:51 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:01:51 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:01:51 - [info] [hue-bridge:Philips hue] [object Object] 21 Mar 11:01:51 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:01:51 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:01:52 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:01:53 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:01:53 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:01:53 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:01:53 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:02:01 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:02:01 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:02:01 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:02:03 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:02:03 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:02:03 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:02:03 - [info] [hue-bridge:Philips hue] Subscribing to bridge events… 21 Mar 11:02:22 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:02:22 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:02:22 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:02:23 - [info] [hue-bridge:Philips hue] Error requesting info from the bridge. Reconnect in some secs. undefined 21 Mar 11:02:23 - [info] [hue-bridge:Philips hue] Initializing the bridge (192.168.0.150)… 21 Mar 11:02:23 - [info] [hue-bridge:Philips hue] Connected to bridge 21 Mar 11:02:23 - [info] [hue-bridge:Philips hue] Processing bridge resources… 21 Mar 11:02:23 - [info] [hue-bridge:Philips hue] Initial emit of resource states… 21 Mar 11:02:24 - [info] [hue-bridge:Philips hue] Keeping nodes up-to-date… 21 Mar 11:02:24 - [info] [hue-bridge:Philips hue] Subscribing to bridge events…