Error in Homebridge log

[euphguy]

I've had this up and running for a few days normally. This morning I have the following error in the logs and no data is flowing to HomeKit.

Connection to the envoy homepage is slow but it loads.

[8/30/2021, 9:22:24 AM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, homeData error: Error: Parse Error: Content-Length can't be present with Transfer-Encoding at HTTPParser.execute () at Socket.socketOnData (_http_client.js:515:22) at Socket.emit (events.js:375:28) at addChunk (internal/streams/readable.js:290:12) at readableAddChunk (internal/streams/readable.js:265:9) at Socket.Readable.push (internal/streams/readable.js:204:10) at TCP.onStreamRead (internal/stream_base_commons.js:188:23) { bytesParsed: 242, code: 'HPE_UNEXPECTED_CONTENT_LENGTH', reason: "Content-Length can't be present with Transfer-Encoding", rawPacket: <Buffer 48 54 54 50 2f 31 2e 31 20 33 30 31 20 4d 6f 76 65 64 20 50 65 72 6d 61 6e 65 6e 74 6c 79 0d 0a 44 61 74 65 3a 20 4d 6f 6e 2c 20 33 30 20 41 75 67 20 ... 192 more bytes>, config: [Object], request: [Writable], response: undefined, isAxiosError: true, toJSON: [Function: toJSON] }

[grzegorz914]

Check please Your Envoy Firmware #36 , may be was updated over the night?

[euphguy]

I don't believe it was updated. Version D5.0.55

[grzegorz914]

Try to restart Envoy or check network Connecrivity

[euphguy]

Thank you for helping.

I power cycled the Envoy. I can connect to the local web server (very slowly). I Still have the same error.

I am going to see if I can improve the wifi connection and I will report back.

[euphguy]

I've improved the wifi connection slightly and I have also completely removed the plugin and config, restarted the server, added the plugin back in. With debug mode on I see this every 10 seconds:

[8/30/2021, 4:31:04 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, requesting infoData. [8/30/2021, 4:31:07 PM] [enphaseEnvoy] Device 192.168.1.177 Envoy Solar, debug infoData: <?xml version='1.0' encoding='UTF-8'?>

1630355467 202123025581 800-00655-r09 D5.0.55 4c8675 0 1 true 500-00001-r01 02.00.00 950 500-00011-r01 04.01.15 1905ae 590-00019-r01 02.00.01 1f421b 500-00002-r01 05.00.55 4f2662 500-00004-r01 01.02.293 9cf065 500-00008-r01 02.01.22 2faa48 500-00010-r01 05.00.02 4fe435 500-00013-r01 03.02.07 276642 500-00012-r01 02.02.00 8969f6 500-00016-r01 02.00.00 54a6dc 1607601617 release-5.0.x-106-Dec-10-20-02:30:12

[8/30/2021, 4:31:07 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, parse info.xml successful: { "envoy_info": { "time": [ "1630355467" ], "device": [ { "sn": [ "202123025581" ], "pn": [ "800-00655-r09" ], "software": [ "D5.0.55" ], "euaid": [ "4c8675" ], "seqnum": [ "0" ], "apiver": [ "1" ], "imeter": [ "true" ] } ], "package": [ { "$": { "name": "rootfs" }, "pn": [ "500-00001-r01" ], "version": [ "02.00.00" ], "build": [ "950" ] }, { "$": { "name": "kernel" }, "pn": [ "500-00011-r01" ], "version": [ "04.01.15" ], "build": [ "1905ae" ] }, { "$": { "name": "boot" }, "pn": [ "590-00019-r01" ], "version": [ "02.00.01" ], "build": [ "1f421b" ] }, { "$": { "name": "app" }, "pn": [ "500-00002-r01" ], "version": [ "05.00.55" ], "build": [ "4f2662" ] }, { "$": { "name": "devimg" }, "pn": [ "500-00004-r01" ], "version": [ "01.02.293" ], "build": [ "9cf065" ] }, { "$": { "name": "geo" }, "pn": [ "500-00008-r01" ], "version": [ "02.01.22" ], "build": [ "2faa48" ] }, { "$": { "name": "backbone" }, "pn": [ "500-00010-r01" ], "version": [ "05.00.02" ], "build": [ "4fe435" ] }, { "$": { "name": "meter" }, "pn": [ "500-00013-r01" ], "version": [ "03.02.07" ], "build": [ "276642" ] }, { "$": { "name": "agf" }, "pn": [ "500-00012-r01" ], "version": [ "02.02.00" ], "build": [ "8969f6" ] }, { "$": { "name": "security" }, "pn": [ "500-00016-r01" ], "version": [ "02.00.00" ], "build": [ "54a6dc" ] } ], "build_info": [ { "build_time_gmt": [ "1607601617" ], "build_id": [ "release-5.0.x-106-Dec-10-20-02:30:12" ] } ] }

[grzegorz914]

All OK in this log

[euphguy]

OK, so with debug mode off the plugin never seems to load fully. No mention of the plugin in the logs other than "[enphaseEnvoy] Initializing enphaseEnvoy platform..."

[grzegorz914]

Can You post comlete debug log?

[euphguy]

`[8/30/2021, 5:04:07 PM] [HB Supervisor] OS: Linux 5.10.17-v7+ arm [8/30/2021, 5:04:07 PM] [HB Supervisor] Node.js v14.17.2 /usr/bin/node [8/30/2021, 5:04:07 PM] [HB Supervisor] Homebridge Path: /usr/lib/node_modules/homebridge/bin/homebridge [8/30/2021, 5:04:07 PM] [HB Supervisor] UI Path: /usr/lib/node_modules/homebridge-config-ui-x/dist/bin/standalone.js [8/30/2021, 5:04:45 PM] [Homebridge UI] Homebridge Config UI X v4.41.2 is listening on :: port 8581 [8/30/2021, 5:04:48 PM] [HB Supervisor] Starting Homebridge with extra flags: -I -D [8/30/2021, 5:04:48 PM] [HB Supervisor] Started Homebridge v1.3.4 with PID: 10600 Initializing HAP-NodeJS v0.9.4... [8/30/2021, 5:04:53 PM] [Homebridge UI] Starting terminal session [8/30/2021, 5:04:55 PM] Loaded config.json with 1 accessories and 5 platforms. [8/30/2021, 5:04:56 PM] Loaded 0 cached accessories from cachedAccessories. [8/30/2021, 5:04:56 PM] --- [8/30/2021, 5:05:04 PM] Plugin /usr/lib/node_modules/homebridge-platform-helper package.json does not contain the keyword 'homebridge-plugin'. [8/30/2021, 5:05:04 PM] Plugin /usr/lib/node_modules/homebridge-weather-plus does not contain a package.json. [8/30/2021, 5:05:04 PM] Loaded plugin: homebridge-august-smart-locks@5.0.9 [8/30/2021, 5:05:04 PM] Registering platform 'homebridge-august-smart-locks.AugustLocks' [8/30/2021, 5:05:04 PM] --- [8/30/2021, 5:05:11 PM] [Homebridge UI] Terminal session ended. [8/30/2021, 5:05:27 PM] Loaded plugin: homebridge-broadlink-rm-pro@4.4.7-beta.1 [8/30/2021, 5:05:27 PM] Plugin 'homebridge-broadlink-rm-pro' tried to register with an incorrect plugin identifier: 'homebridge-broadlink-rm'. Please report this to the developer! [8/30/2021, 5:05:27 PM] Registering platform 'homebridge-broadlink-rm-pro.BroadlinkRM' [8/30/2021, 5:05:27 PM] --- [8/30/2021, 5:05:28 PM] Loaded plugin: homebridge-config-ui-x@4.41.2 [8/30/2021, 5:05:28 PM] Registering platform 'homebridge-config-ui-x.config' [8/30/2021, 5:05:28 PM] --- [8/30/2021, 5:05:28 PM] Loaded plugin: homebridge-enphase-envoy@5.4.12 [8/30/2021, 5:05:28 PM] Registering platform 'homebridge-enphase-envoy.enphaseEnvoy' [8/30/2021, 5:05:28 PM] --- [8/30/2021, 5:05:28 PM] Loaded plugin: homebridge-fakeswitch@0.0.3 [8/30/2021, 5:05:28 PM] Registering accessory 'homebridge-fakeswitch.FakeSwitch' [8/30/2021, 5:05:28 PM] --- [8/30/2021, 5:05:29 PM] Loaded plugin: homebridge-platform-orbit@1.5.2 [8/30/2021, 5:05:29 PM] Registering platform 'homebridge-platform-orbit.orbit' [8/30/2021, 5:05:29 PM] --- [8/30/2021, 5:05:29 PM] Loading 5 platforms... [8/30/2021, 5:05:29 PM] [Broadlink RM] Initializing BroadlinkRM platform... [8/30/2021, 5:05:29 PM] [Broadlink RM] [INFO] Automatically discovering Broadlink RM devices. [8/30/2021, 5:05:29 PM] [Broadlink RM] TV Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] HVAC Off Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] AC Heat (day) Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] AC Heat (night) Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] AC Cool (72°) Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] AC (night) Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] AC (Auto) Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] AC Off Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] AC Power Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] AC Energy Saver Accessory Ready [8/30/2021, 5:05:29 PM] [Broadlink RM] [8/30/2021, 5:05:29 PM] [Broadlink RM] ** [8/30/2021, 5:05:29 PM] [Broadlink RM] You added TVs in your configuration! [8/30/2021, 5:05:29 PM] [Broadlink RM] Due to a HomeKit limitation you need to add any TVs to the Home app by using the Add Accessory function. [8/30/2021, 5:05:29 PM] [Broadlink RM] There you'll find your TVs and you can use the same PIN as you using for this HomeBridge instance. [8/30/2021, 5:05:29 PM] [Broadlink RM] ** [8/30/2021, 5:05:29 PM] [Broadlink RM] [8/30/2021, 5:05:29 PM] [Config] Initializing config platform... [8/30/2021, 5:05:29 PM] [Config] Running in Service Mode [8/30/2021, 5:05:29 PM] [AugustLocks] Initializing AugustLocks platform... [8/30/2021, 5:05:29 PM] [AugustLocks] Initializing child bridge 0E:A4:A6:92:84:60 [8/30/2021, 5:05:29 PM] [orbit] Initializing orbit platform... [8/30/2021, 5:05:29 PM] [orbit] Initializing child bridge 0E:2E:67:A8:B3:69 [8/30/2021, 5:05:29 PM] [enphaseEnvoy] Initializing enphaseEnvoy platform... [8/30/2021, 5:05:29 PM] Loading 1 accessories... [8/30/2021, 5:05:29 PM] [Max Power] Initializing FakeSwitch accessory... [8/30/2021, 5:05:29 PM] [Max Power] Setting switch to false [8/30/2021, 5:05:30 PM] [enphaseEnvoy] didFinishLaunching [8/30/2021, 5:05:30 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, requesting infoData. Preparing Advertiser for 'TV C584' using ciao backend! [8/30/2021, 5:05:30 PM] Initializing platform accessory 'HVAC Off'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'AC Heat (day)'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'AC Heat (night)'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'AC Cool (72°)'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'Learn (Den)'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'Learn (Bedroom)'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'AC (night)'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'AC (Auto)'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'AC Off'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'AC Power'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'AC Energy Saver'... [8/30/2021, 5:05:30 PM] Initializing platform accessory 'Learn (Jeremy's Bedroom)'... Preparing Advertiser for 'Homebridge CAD8' using ciao backend! Setup Payload: X-HM://0023ISYWYN8BP Enter this code with your HomeKit app on your iOS device to pair with Homebridge:

┌────────────┐     
│ 031-45-154 │     
└────────────┘     

Starting to advertise 'TV C584' using ciao backend! [8/30/2021, 5:05:30 PM] TV C584 is running on port 39371. [8/30/2021, 5:05:30 PM] Please add [TV C584] manually in Home app. Setup Code: 031-45-154 Starting to advertise 'Homebridge CAD8' using ciao backend! [8/30/2021, 5:05:30 PM] Homebridge v1.3.4 (Homebridge) is running on port 51826. [INFO] Adding RF Support to device 780f77b91505 with type 279d [8/30/2021, 5:05:31 PM] [Broadlink RM] [8/30/2021, 5:05:31 PM] [Broadlink RM] ** [8/30/2021, 5:05:31 PM] [Broadlink RM] Welcome to version 4.4.7-beta.1 of the Homebridge Broadlink RM Plugin! [8/30/2021, 5:05:31 PM] [Broadlink RM] [8/30/2021, 5:05:31 PM] [Broadlink RM] Find out what's in the latest release here: https://github.com/kiwi-cam/homebridge-broadlink-rm/blob/master/CHANGELOG.md [8/30/2021, 5:05:31 PM] [Broadlink RM] [8/30/2021, 5:05:31 PM] [Broadlink RM] If you like this plugin then please star it on GitHub or better yet [8/30/2021, 5:05:31 PM] [Broadlink RM] buy me a drink using Paypal https://paypal.me/kiwicamRM. [8/30/2021, 5:05:31 PM] [Broadlink RM] [8/30/2021, 5:05:31 PM] [Broadlink RM] You can disable this message by adding "hideWelcomeMessage": true to the config (see config-sample.json). [8/30/2021, 5:05:31 PM] [Broadlink RM] [8/30/2021, 5:05:31 PM] [Broadlink RM] **** [8/30/2021, 5:05:31 PM] [Broadlink RM] [8/30/2021, 5:05:31 PM] [Broadlink RM] [INFO] Discovered Broadlink RM3 Mini B (5f36) at 192.168.1.160 (��B@�:) [8/30/2021, 5:05:31 PM] [Broadlink RM] [INFO] Discovered Broadlink RM3 Mini (2737) at 192.168.1.207 (c8:f7:42:16:f8:d5) [8/30/2021, 5:05:31 PM] [Broadlink RM] [INFO] Discovered Broadlink RM3 Pro Plus (279d) at 192.168.1.151 (78:0f:77:b9:15:05) [8/30/2021, 5:05:31 PM] [enphaseEnvoy] Device 192.168.1.177 Envoy Solar, debug infoData: <?xml version='1.0' encoding='UTF-8'?>

1630357531 202123025581 800-00655-r09 D5.0.55 4c8675 0 1 true 500-00001-r01 02.00.00 950 500-00011-r01 04.01.15 1905ae 590-00019-r01 02.00.01 1f421b 500-00002-r01 05.00.55 4f2662 500-00004-r01 01.02.293 9cf065 500-00008-r01 02.01.22 2faa48 500-00010-r01 05.00.02 4fe435 500-00013-r01 03.02.07 276642 500-00012-r01 02.02.00 8969f6 500-00016-r01 02.00.00 54a6dc 1607601617 release-5.0.x-106-Dec-10-20-02:30:12

[8/30/2021, 5:05:32 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, parse info.xml successful: { "envoy_info": { "time": [ "1630357531" ], "device": [ { "sn": [ "202123025581" ], "pn": [ "800-00655-r09" ], "software": [ "D5.0.55" ], "euaid": [ "4c8675" ], "seqnum": [ "0" ], "apiver": [ "1" ], "imeter": [ "true" ] } ], "package": [ { "$": { "name": "rootfs" }, "pn": [ "500-00001-r01" ], "version": [ "02.00.00" ], "build": [ "950" ] }, { "$": { "name": "kernel" }, "pn": [ "500-00011-r01" ], "version": [ "04.01.15" ], "build": [ "1905ae" ] }, { "$": { "name": "boot" }, "pn": [ "590-00019-r01" ], "version": [ "02.00.01" ], "build": [ "1f421b" ] }, { "$": { "name": "app" }, "pn": [ "500-00002-r01" ], "version": [ "05.00.55" ], "build": [ "4f2662" ] }, { "$": { "name": "devimg" }, "pn": [ "500-00004-r01" ], "version": [ "01.02.293" ], "build": [ "9cf065" ] }, { "$": { "name": "geo" }, "pn": [ "500-00008-r01" ], "version": [ "02.01.22" ], "build": [ "2faa48" ] }, { "$": { "name": "backbone" }, "pn": [ "500-00010-r01" ], "version": [ "05.00.02" ], "build": [ "4fe435" ] }, { "$": { "name": "meter" }, "pn": [ "500-00013-r01" ], "version": [ "03.02.07" ], "build": [ "276642" ] }, { "$": { "name": "agf" }, "pn": [ "500-00012-r01" ], "version": [ "02.02.00" ], "build": [ "8969f6" ] }, { "$": { "name": "security" }, "pn": [ "500-00016-r01" ], "version": [ "02.00.00" ], "build": [ "54a6dc" ] } ], "build_info": [ { "build_time_gmt": [ "1607601617" ], "build_id": [ "release-5.0.x-106-Dec-10-20-02:30:12" ] } ] } } Initializing HAP-NodeJS v0.9.4... Initializing HAP-NodeJS v0.9.4... [8/30/2021, 5:05:35 PM] [orbit] Launched child bridge with PID 10642 [8/30/2021, 5:05:35 PM] [AugustLocks] Launched child bridge with PID 10641 [8/30/2021, 5:05:36 PM] Registering platform 'homebridge-platform-orbit.orbit' [8/30/2021, 5:05:36 PM] [orbit] Loaded homebridge-platform-orbit v1.5.2 child bridge successfully [8/30/2021, 5:05:36 PM] Registering platform 'homebridge-august-smart-locks.AugustLocks' [8/30/2021, 5:05:36 PM] [AugustLocks] Loaded homebridge-august-smart-locks v5.0.9 child bridge successfully [8/30/2021, 5:05:36 PM] Loaded 1 cached accessories from cachedAccessories.0EA4A6928460. [8/30/2021, 5:05:36 PM] Loaded 1 cached accessories from cachedAccessories.0E2E67A8B369. [8/30/2021, 5:05:37 PM] [orbit] Starting PlatformOrbit using homebridge API 2.7 [8/30/2021, 5:05:37 PM] [orbit] Loading accessory from cache Irrigation Preparing Advertiser for 'orbit 7FB7' using ciao backend! [8/30/2021, 5:05:37 PM] [orbit] Loading the devices Starting to advertise 'orbit 7FB7' using ciao backend! [8/30/2021, 5:05:37 PM] Homebridge v1.3.4 (orbit) is running on port 59501. Preparing Advertiser for 'AugustLocks F411' using ciao backend! [8/30/2021, 5:05:37 PM] [AugustLocks] [August] getting locks ... Starting to advertise 'AugustLocks F411' using ciao backend! [8/30/2021, 5:05:38 PM] Homebridge v1.3.4 (AugustLocks) is running on port 54623. [8/30/2021, 5:05:40 PM] [AugustLocks] [August] Home Front Door [8/30/2021, 5:05:40 PM] [AugustLocks] [August] LockId 90E05AC198714E3381DB9DD69FE5DE58 [8/30/2021, 5:05:40 PM] [orbit] Configuring cached device Irrigation [8/30/2021, 5:05:40 PM] [orbit] Configure Irrigation service Irrigation [8/30/2021, 5:05:40 PM] [orbit] Configure Valve service North Spray [8/30/2021, 5:05:40 PM] [orbit] Configure Valve service Front Rotors [8/30/2021, 5:05:40 PM] [orbit] Configure Valve service South Spray [8/30/2021, 5:05:40 PM] [orbit] Configure Valve service Rear 1 [8/30/2021, 5:05:40 PM] [orbit] Configure Valve service Rear 2 [8/30/2021, 5:05:40 PM] [orbit] openConnection [8/30/2021, 5:05:40 PM] [orbit] onMessage [8/30/2021, 5:05:40 PM] [orbit] sync [8/30/2021, 5:05:40 PM] [orbit] IrrigationSystem Irrigation Active = ACTIVE [8/30/2021, 5:05:40 PM] [orbit] IrrigationSystem Irrigation ProgramMode = 1 [8/30/2021, 5:05:40 PM] [orbit] IrrigationSystem Irrigation InUse = NOT_IN_USE [8/30/2021, 5:05:40 PM] [orbit] IrrigationSystem Irrigation RemainingDuration = 0 [8/30/2021, 5:05:40 PM] [orbit] IrrigationSystem Irrigation StatusFault = NO_FAULT [8/30/2021, 5:05:40 PM] [orbit] Valve North Spray Active = INACTIVE [8/30/2021, 5:05:40 PM] [orbit] Valve North Spray InUse = NOT_IN_USE [8/30/2021, 5:05:40 PM] [orbit] Valve North Spray ValveType = 1 [8/30/2021, 5:05:40 PM] [orbit] Valve North Spray SetDuration = 300 [8/30/2021, 5:05:40 PM] [orbit] Valve North Spray RemainingDuration = 0 [8/30/2021, 5:05:40 PM] [orbit] Valve North Spray IsConfigured = CONFIGURED [8/30/2021, 5:05:40 PM] [orbit] Valve North Spray StatusFault = NO_FAULT [8/30/2021, 5:05:40 PM] [orbit] Valve Front Rotors Active = INACTIVE [8/30/2021, 5:05:40 PM] [orbit] Valve Front Rotors InUse = NOT_IN_USE [8/30/2021, 5:05:40 PM] [orbit] Valve Front Rotors ValveType = 1 [8/30/2021, 5:05:40 PM] [orbit] Valve Front Rotors SetDuration = 300 [8/30/2021, 5:05:40 PM] [orbit] Valve Front Rotors RemainingDuration = 0 [8/30/2021, 5:05:40 PM] [orbit] Valve Front Rotors IsConfigured = CONFIGURED [8/30/2021, 5:05:40 PM] [orbit] Valve Front Rotors StatusFault = NO_FAULT [8/30/2021, 5:05:40 PM] [orbit] Valve South Spray Active = INACTIVE [8/30/2021, 5:05:40 PM] [orbit] Valve South Spray InUse = NOT_IN_USE [8/30/2021, 5:05:40 PM] [orbit] Valve South Spray ValveType = 1 [8/30/2021, 5:05:40 PM] [orbit] Valve South Spray SetDuration = 300 [8/30/2021, 5:05:40 PM] [orbit] Valve South Spray RemainingDuration = 0 [8/30/2021, 5:05:40 PM] [orbit] Valve South Spray IsConfigured = CONFIGURED [8/30/2021, 5:05:40 PM] [orbit] Valve South Spray StatusFault = NO_FAULT [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 1 Active = INACTIVE [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 1 InUse = NOT_IN_USE [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 1 ValveType = 1 [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 1 SetDuration = 300 [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 1 RemainingDuration = 0 [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 1 IsConfigured = CONFIGURED [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 1 StatusFault = NO_FAULT [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 2 Active = INACTIVE [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 2 InUse = NOT_IN_USE [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 2 ValveType = 1 [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 2 SetDuration = 300 [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 2 RemainingDuration = 0 [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 2 IsConfigured = CONFIGURED [8/30/2021, 5:05:40 PM] [orbit] Valve Rear 2 StatusFault = NO_FAULT [8/30/2021, 5:05:41 PM] [orbit] WebSocket open [8/30/2021, 5:05:41 PM] [orbit] TX {"event":"app_connection","orbit_session_token":"eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXUyJ9.eyJ1c2VyLWlkIjoiNjA3YjM4ZjY0ZjBjMTYxZDVhMGU1NGNkIiwiYXBwLWlkIjoiT3JiaXQgU3VwcG9ydCBEYXNoYm9hcmQifQ.poXmlAY1OP6sYqufJTJqMI7SgsPdBSDFBc8j4dxbUCo","subscribe_device_id":"607db30d4f0c161d5a0ed681"} [8/30/2021, 5:05:41 PM] [orbit] TX {"event":"sync","device_id":"607db30d4f0c161d5a0ed681"} [8/30/2021, 5:05:41 PM] [orbit] RX {"event":"program_changed","device_id":"607db30d4f0c161d5a0ed681","program":{"update_via":"wifi","name":"Normal","frequency":{"type":"even"},"is_basic_program":false,"updated_at":"2021-08-30T21:05:41.658Z","updated_via":"wifi","start_times":["03:30"],"id":"607db62b4f0c9e0599a567c7","budget":100,"is_smart_program":false,"device_id":"607db30d4f0c161d5a0ed681","program":"a","run_times":[{"station":1,"run_time":20.0},{"station":2,"run_time":40.0},{"station":3,"run_time":20.0},{"station":4,"run_time":30.0},{"station":5,"run_time":30.0}],"enabled":true,"created_at":"2021-04-19T16:56:11.169Z"},"lifecycle_phase":"update","timestamp":"2021-08-30T21:05:41.669Z"} [8/30/2021, 5:05:41 PM] [orbit] program_change - do nothing [8/30/2021, 5:05:41 PM] [orbit] RX {"timestamp":"2021-08-30T21:06:12.000Z","event":"device_idle","stream-id":"ad374c9c-9b21-495b-8e7a-7ec61bd03080","client-topics":["device-clients-1"],"gateway-topic":"devices-7","device_id":"607db30d4f0c161d5a0ed681"} [8/30/2021, 5:05:41 PM] [orbit] Watering_complete or device_idle [8/30/2021, 5:05:41 PM] [orbit] RX {"event":"change_mode","mode":"auto","device_id":"607db30d4f0c161d5a0ed681","timestamp":"2021-08-30T21:06:12.000Z"} [8/30/2021, 5:05:41 PM] [orbit] change_mode auto [8/30/2021, 5:05:41 PM] [orbit] RX {"event":"rain_delay","delay":0,"rain_sensors":[],"device_id":"607db30d4f0c161d5a0ed681","timestamp":"2021-08-30T21:06:12.000Z"} [8/30/2021, 5:05:41 PM] [orbit] rain_delay - do nothing [8/30/2021, 5:05:41 PM] [orbit] RX {"event":"change_mode","mode":"auto","device_id":"607db30d4f0c161d5a0ed681","timestamp":"2021-08-30T21:06:12.000Z"} [8/30/2021, 5:05:41 PM] [orbit] change_mode auto [8/30/2021, 5:05:41 PM] [orbit] RX {"event":"program_changed","device_id":"607db30d4f0c161d5a0ed681","program":{"update_via":"wifi","name":"Normal","frequency":{"type":"even"},"is_basic_program":false,"updated_at":"2021-08-30T21:05:41.814Z","updated_via":"wifi","start_times":["03:30"],"id":"607db62b4f0c9e0599a567c7","budget":100,"is_smart_program":false,"device_id":"607db30d4f0c161d5a0ed681","program":"a","run_times":[{"run_time":20.0,"station":1},{"run_time":40.0,"station":2},{"run_time":20.0,"station":3},{"run_time":30.0,"station":4},{"run_time":30.0,"station":5}],"enabled":false,"created_at":"2021-04-19T16:56:11.169Z"},"lifecycle_phase":"update","timestamp":"2021-08-30T21:05:41.825Z"} [8/30/2021, 5:05:41 PM] [orbit] program_change - do nothing [8/30/2021, 5:05:45 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, requesting infoData. [8/30/2021, 5:05:47 PM] [orbit] IrrigationSystem Irrigation Active = ACTIVE [8/30/2021, 5:05:47 PM] [orbit] IrrigationSystem Irrigation ProgramMode = 1 [8/30/2021, 5:05:47 PM] [orbit] IrrigationSystem Irrigation InUse = NOT_IN_USE [8/30/2021, 5:05:47 PM] [orbit] IrrigationSystem Irrigation RemainingDuration = 0 [8/30/2021, 5:05:47 PM] [orbit] IrrigationSystem Irrigation StatusFault = NO_FAULT [8/30/2021, 5:05:47 PM] [orbit] Valve North Spray Active = INACTIVE [8/30/2021, 5:05:47 PM] [orbit] Valve North Spray InUse = NOT_IN_USE [8/30/2021, 5:05:47 PM] [orbit] Valve North Spray ValveType = 1 [8/30/2021, 5:05:47 PM] [orbit] Valve North Spray SetDuration = 300 [8/30/2021, 5:05:47 PM] [orbit] Valve North Spray RemainingDuration = 0 [8/30/2021, 5:05:47 PM] [orbit] Valve North Spray IsConfigured = CONFIGURED [8/30/2021, 5:05:47 PM] [orbit] Valve North Spray StatusFault = NO_FAULT [8/30/2021, 5:05:47 PM] [orbit] Valve Front Rotors Active = INACTIVE [8/30/2021, 5:05:47 PM] [orbit] Valve Front Rotors InUse = NOT_IN_USE [8/30/2021, 5:05:47 PM] [orbit] Valve Front Rotors ValveType = 1 [8/30/2021, 5:05:47 PM] [orbit] Valve Front Rotors SetDuration = 300 [8/30/2021, 5:05:47 PM] [orbit] Valve Front Rotors RemainingDuration = 0 [8/30/2021, 5:05:47 PM] [orbit] Valve Front Rotors IsConfigured = CONFIGURED [8/30/2021, 5:05:47 PM] [orbit] Valve Front Rotors StatusFault = NO_FAULT [8/30/2021, 5:05:47 PM] [orbit] Valve South Spray Active = INACTIVE [8/30/2021, 5:05:47 PM] [orbit] Valve South Spray InUse = NOT_IN_USE [8/30/2021, 5:05:47 PM] [orbit] Valve South Spray ValveType = 1 [8/30/2021, 5:05:47 PM] [orbit] Valve South Spray SetDuration = 300 [8/30/2021, 5:05:47 PM] [orbit] Valve South Spray RemainingDuration = 0 [8/30/2021, 5:05:47 PM] [orbit] Valve South Spray IsConfigured = CONFIGURED [8/30/2021, 5:05:47 PM] [orbit] Valve South Spray StatusFault = NO_FAULT [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 1 Active = INACTIVE [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 1 InUse = NOT_IN_USE [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 1 ValveType = 1 [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 1 SetDuration = 300 [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 1 RemainingDuration = 0 [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 1 IsConfigured = CONFIGURED [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 1 StatusFault = NO_FAULT [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 2 Active = INACTIVE [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 2 InUse = NOT_IN_USE [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 2 ValveType = 1 [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 2 SetDuration = 300 [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 2 RemainingDuration = 0 [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 2 IsConfigured = CONFIGURED [8/30/2021, 5:05:47 PM] [orbit] Valve Rear 2 StatusFault = NO_FAULT [8/30/2021, 5:05:48 PM] [enphaseEnvoy] Device 192.168.1.177 Envoy Solar, debug infoData: <?xml version='1.0' encoding='UTF-8'?>

1630357546 202123025581 800-00655-r09 D5.0.55 4c8675 0 1 true 500-00001-r01 02.00.00 950 500-00011-r01 04.01.15 1905ae 590-00019-r01 02.00.01 1f421b 500-00002-r01 05.00.55 4f2662 500-00004-r01 01.02.293 9cf065 500-00008-r01 02.01.22 2faa48 500-00010-r01 05.00.02 4fe435 500-00013-r01 03.02.07 276642 500-00012-r01 02.02.00 8969f6 500-00016-r01 02.00.00 54a6dc 1607601617 release-5.0.x-106-Dec-10-20-02:30:12

[8/30/2021, 5:05:48 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, parse info.xml successful: { "envoy_info": { "time": [ "1630357546" ], "device": [ { "sn": [ "202123025581" ], "pn": [ "800-00655-r09" ], "software": [ "D5.0.55" ], "euaid": [ "4c8675" ], "seqnum": [ "0" ], "apiver": [ "1" ], "imeter": [ "true" ] } ], "package": [ { "$": { "name": "rootfs" }, "pn": [ "500-00001-r01" ], "version": [ "02.00.00" ], "build": [ "950" ] }, { "$": { "name": "kernel" }, "pn": [ "500-00011-r01" ], "version": [ "04.01.15" ], "build": [ "1905ae" ] }, { "$": { "name": "boot" }, "pn": [ "590-00019-r01" ], "version": [ "02.00.01" ], "build": [ "1f421b" ] }, { "$": { "name": "app" }, "pn": [ "500-00002-r01" ], "version": [ "05.00.55" ], "build": [ "4f2662" ] }, { "$": { "name": "devimg" }, "pn": [ "500-00004-r01" ], "version": [ "01.02.293" ], "build": [ "9cf065" ] }, { "$": { "name": "geo" }, "pn": [ "500-00008-r01" ], "version": [ "02.01.22" ], "build": [ "2faa48" ] }, { "$": { "name": "backbone" }, "pn": [ "500-00010-r01" ], "version": [ "05.00.02" ], "build": [ "4fe435" ] }, { "$": { "name": "meter" }, "pn": [ "500-00013-r01" ], "version": [ "03.02.07" ], "build": [ "276642" ] }, { "$": { "name": "agf" }, "pn": [ "500-00012-r01" ], "version": [ "02.02.00" ], "build": [ "8969f6" ] }, { "$": { "name": "security" }, "pn": [ "500-00016-r01" ], "version": [ "02.00.00" ], "build": [ "54a6dc" ] } ], "build_info": [ { "build_time_gmt": [ "1607601617" ], "build_id": [ "release-5.0.x-106-Dec-10-20-02:30:12" ] } ] } } [8/30/2021, 5:06:00 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, requesting infoData. [8/30/2021, 5:06:01 PM] [enphaseEnvoy] Device 192.168.1.177 Envoy Solar, debug infoData: <?xml version='1.0' encoding='UTF-8'?>

1630357559 202123025581 800-00655-r09 D5.0.55 4c8675 0 1 true 500-00001-r01 02.00.00 950 500-00011-r01 04.01.15 1905ae 590-00019-r01 02.00.01 1f421b 500-00002-r01 05.00.55 4f2662 500-00004-r01 01.02.293 9cf065 500-00008-r01 02.01.22 2faa48 500-00010-r01 05.00.02 4fe435 500-00013-r01 03.02.07 276642 500-00012-r01 02.02.00 8969f6 500-00016-r01 02.00.00 54a6dc 1607601617 release-5.0.x-106-Dec-10-20-02:30:12

[8/30/2021, 5:06:01 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, parse info.xml successful: { "envoy_info": { "time": [ "1630357559" ], "device": [ { "sn": [ "202123025581" ], "pn": [ "800-00655-r09" ], "software": [ "D5.0.55" ], "euaid": [ "4c8675" ], "seqnum": [ "0" ], "apiver": [ "1" ], "imeter": [ "true" ] } ], "package": [ { "$": { "name": "rootfs" }, "pn": [ "500-00001-r01" ], "version": [ "02.00.00" ], "build": [ "950" ] }, { "$": { "name": "kernel" }, "pn": [ "500-00011-r01" ], "version": [ "04.01.15" ], "build": [ "1905ae" ] }, { "$": { "name": "boot" }, "pn": [ "590-00019-r01" ], "version": [ "02.00.01" ], "build": [ "1f421b" ] }, { "$": { "name": "app" }, "pn": [ "500-00002-r01" ], "version": [ "05.00.55" ], "build": [ "4f2662" ] }, { "$": { "name": "devimg" }, "pn": [ "500-00004-r01" ], "version": [ "01.02.293" ], "build": [ "9cf065" ] }, { "$": { "name": "geo" }, "pn": [ "500-00008-r01" ], "version": [ "02.01.22" ], "build": [ "2faa48" ] }, { "$": { "name": "backbone" }, "pn": [ "500-00010-r01" ], "version": [ "05.00.02" ], "build": [ "4fe435" ] }, { "$": { "name": "meter" }, "pn": [ "500-00013-r01" ], "version": [ "03.02.07" ], "build": [ "276642" ] }, { "$": { "name": "agf" }, "pn": [ "500-00012-r01" ], "version": [ "02.02.00" ], "build": [ "8969f6" ] }, { "$": { "name": "security" }, "pn": [ "500-00016-r01" ], "version": [ "02.00.00" ], "build": [ "54a6dc" ] } ], "build_info": [ { "build_time_gmt": [ "1607601617" ], "build_id": [ "release-5.0.x-106-Dec-10-20-02:30:12" ] } ] } } [8/30/2021, 5:06:05 PM] [orbit] TX {"event":"ping"} [8/30/2021, 5:06:15 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, requesting infoData. [8/30/2021, 5:06:16 PM] [enphaseEnvoy] Device 192.168.1.177 Envoy Solar, debug infoData: <?xml version='1.0' encoding='UTF-8'?>

1630357575 202123025581 800-00655-r09 D5.0.55 4c8675 0 1 true 500-00001-r01 02.00.00 950 500-00011-r01 04.01.15 1905ae 590-00019-r01 02.00.01 1f421b 500-00002-r01 05.00.55 4f2662 500-00004-r01 01.02.293 9cf065 500-00008-r01 02.01.22 2faa48 500-00010-r01 05.00.02 4fe435 500-00013-r01 03.02.07 276642 500-00012-r01 02.02.00 8969f6 500-00016-r01 02.00.00 54a6dc 1607601617 release-5.0.x-106-Dec-10-20-02:30:12

[8/30/2021, 5:06:16 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, parse info.xml successful: { "envoy_info": { "time": [ "1630357575" ], "device": [ { "sn": [ "202123025581" ], "pn": [ "800-00655-r09" ], "software": [ "D5.0.55" ], "euaid": [ "4c8675" ], "seqnum": [ "0" ], "apiver": [ "1" ], "imeter": [ "true" ] } ], "package": [ { "$": { "name": "rootfs" }, "pn": [ "500-00001-r01" ], "version": [ "02.00.00" ], "build": [ "950" ] }, { "$": { "name": "kernel" }, "pn": [ "500-00011-r01" ], "version": [ "04.01.15" ], "build": [ "1905ae" ] }, { "$": { "name": "boot" }, "pn": [ "590-00019-r01" ], "version": [ "02.00.01" ], "build": [ "1f421b" ] }, { "$": { "name": "app" }, "pn": [ "500-00002-r01" ], "version": [ "05.00.55" ], "build": [ "4f2662" ] }, { "$": { "name": "devimg" }, "pn": [ "500-00004-r01" ], "version": [ "01.02.293" ], "build": [ "9cf065" ] }, { "$": { "name": "geo" }, "pn": [ "500-00008-r01" ], "version": [ "02.01.22" ], "build": [ "2faa48" ] }, { "$": { "name": "backbone" }, "pn": [ "500-00010-r01" ], "version": [ "05.00.02" ], "build": [ "4fe435" ] }, { "$": { "name": "meter" }, "pn": [ "500-00013-r01" ], "version": [ "03.02.07" ], "build": [ "276642" ] }, { "$": { "name": "agf" }, "pn": [ "500-00012-r01" ], "version": [ "02.02.00" ], "build": [ "8969f6" ] }, { "$": { "name": "security" }, "pn": [ "500-00016-r01" ], "version": [ "02.00.00" ], "build": [ "54a6dc" ] } ], "build_info": [ { "build_time_gmt": [ "1607601617" ], "build_id": [ "release-5.0.x-106-Dec-10-20-02:30:12" ] } ] } } [8/30/2021, 5:06:30 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, requesting infoData. [8/30/2021, 5:06:31 PM] [enphaseEnvoy] Device 192.168.1.177 Envoy Solar, debug infoData: <?xml version='1.0' encoding='UTF-8'?>

1630357590 202123025581 800-00655-r09 D5.0.55 4c8675 0 1 true 500-00001-r01 02.00.00 950 500-00011-r01 04.01.15 1905ae 590-00019-r01 02.00.01 1f421b 500-00002-r01 05.00.55 4f2662 500-00004-r01 01.02.293 9cf065 500-00008-r01 02.01.22 2faa48 500-00010-r01 05.00.02 4fe435 500-00013-r01 03.02.07 276642 500-00012-r01 02.02.00 8969f6 500-00016-r01 02.00.00 54a6dc 1607601617 release-5.0.x-106-Dec-10-20-02:30:12

[8/30/2021, 5:06:31 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, parse info.xml successful: { "envoy_info": { "time": [ "1630357590" ], "device": [ { "sn": [ "202123025581" ], "pn": [ "800-00655-r09" ], "software": [ "D5.0.55" ], "euaid": [ "4c8675" ], "seqnum": [ "0" ], "apiver": [ "1" ], "imeter": [ "true" ] } ], "package": [ { "$": { "name": "rootfs" }, "pn": [ "500-00001-r01" ], "version": [ "02.00.00" ], "build": [ "950" ] }, { "$": { "name": "kernel" }, "pn": [ "500-00011-r01" ], "version": [ "04.01.15" ], "build": [ "1905ae" ] }, { "$": { "name": "boot" }, "pn": [ "590-00019-r01" ], "version": [ "02.00.01" ], "build": [ "1f421b" ] }, { "$": { "name": "app" }, "pn": [ "500-00002-r01" ], "version": [ "05.00.55" ], "build": [ "4f2662" ] }, { "$": { "name": "devimg" }, "pn": [ "500-00004-r01" ], "version": [ "01.02.293" ], "build": [ "9cf065" ] }, { "$": { "name": "geo" }, "pn": [ "500-00008-r01" ], "version": [ "02.01.22" ], "build": [ "2faa48" ] }, { "$": { "name": "backbone" }, "pn": [ "500-00010-r01" ], "version": [ "05.00.02" ], "build": [ "4fe435" ] }, { "$": { "name": "meter" }, "pn": [ "500-00013-r01" ], "version": [ "03.02.07" ], "build": [ "276642" ] }, { "$": { "name": "agf" }, "pn": [ "500-00012-r01" ], "version": [ "02.02.00" ], "build": [ "8969f6" ] }, { "$": { "name": "security" }, "pn": [ "500-00016-r01" ], "version": [ "02.00.00" ], "build": [ "54a6dc" ] } ], "build_info": [ { "build_time_gmt": [ "1607601617" ], "build_id": [ "release-5.0.x-106-Dec-10-20-02:30:12" ] } ] } } [8/30/2021, 5:06:30 PM] [orbit] TX {"event":"ping"} [8/30/2021, 5:06:45 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, requesting infoData. [8/30/2021, 5:06:46 PM] [enphaseEnvoy] Device 192.168.1.177 Envoy Solar, debug infoData: <?xml version='1.0' encoding='UTF-8'?>

1630357605 202123025581 800-00655-r09 D5.0.55 4c8675 0 1 true 500-00001-r01 02.00.00 950 500-00011-r01 04.01.15 1905ae 590-00019-r01 02.00.01 1f421b 500-00002-r01 05.00.55 4f2662 500-00004-r01 01.02.293 9cf065 500-00008-r01 02.01.22 2faa48 500-00010-r01 05.00.02 4fe435 500-00013-r01 03.02.07 276642 500-00012-r01 02.02.00 8969f6 500-00016-r01 02.00.00 54a6dc 1607601617 release-5.0.x-106-Dec-10-20-02:30:12

[8/30/2021, 5:06:46 PM] [enphaseEnvoy] Device: 192.168.1.177 Envoy Solar, parse info.xml successful: { "envoy_info": { "time": [ "1630357605" ], "device": [ { "sn": [ "202123025581" ], "pn": [ "800-00655-r09" ], "software": [ "D5.0.55" ], "euaid": [ "4c8675" ], "seqnum": [ "0" ], "apiver": [ "1" ], "imeter": [ "true" ] } ], "package": [ { "$": { "name": "rootfs" }, "pn": [ "500-00001-r01" ], "version": [ "02.00.00" ], "build": [ "950" ] }, { "$": { "name": "kernel" }, "pn": [ "500-00011-r01" ], "version": [ "04.01.15" ], "build": [ "1905ae" ] }, { "$": { "name": "boot" }, "pn": [ "590-00019-r01" ], "version": [ "02.00.01" ], "build": [ "1f421b" ] }, { "$": { "name": "app" }, "pn": [ "500-00002-r01" ], "version": [ "05.00.55" ], "build": [ "4f2662" ] }, { "$": { "name": "devimg" }, "pn": [ "500-00004-r01" ], "version": [ "01.02.293" ], "build": [ "9cf065" ] }, { "$": { "name": "geo" }, "pn": [ "500-00008-r01" ], "version": [ "02.01.22" ], "build": [ "2faa48" ] }, { "$": { "name": "backbone" }, "pn": [ "500-00010-r01" ], "version": [ "05.00.02" ], "build": [ "4fe435" ] }, { "$": { "name": "meter" }, "pn": [ "500-00013-r01" ], "version": [ "03.02.07" ], "build": [ "276642" ] }, { "$": { "name": "agf" }, "pn": [ "500-00012-r01" ], "version": [ "02.02.00" ], "build": [ "8969f6" ] }, { "$": { "name": "security" }, "pn": [ "500-00016-r01" ], "version": [ "02.00.00" ], "build": [ "54a6dc" ] } ], "build_info": [ { "build_time_gmt": [ "1607601617" ], "build_id": [ "release-5.0.x-106-Dec-10-20-02:30:12" ] } ] } } [8/30/2021, 5:06:55 PM] [orbit] TX `{"event":"ping"}```

[grzegorz914]

Mus be something wrong on your side, plug-in no report any error. Think what You changed before this stopped working.

[euphguy]

Oh well, thanks for reading through those logs

[euphguy]

After much searching I finally found a fix. Nothing directly to do with the plug-in. For future reference: The fix was to use the old Toolkit app.