New OpenSprinkler Plugin

[rloeb]

Sure enough, it's timing out. However, the command was actually executed and the zone turned off (at the time the command was sent). Then I sent a manual off (from the devices page) and it did not time out (although the zone was already off). Very curious!

Rog

Sep-28 12:40:10 PM

OpenSprinkler

All zones are off

Sep-28 12:40:06 PM

OpenSprinkler

Zone 15 off successfully set

Sep-28 12:40:06 PM

OS-Debug

Debug Setter= {"result":1}

Sep-28 12:40:06 PM

OS-Debug

URL: /cm?pw=a6d82bced638de3def1e9bbb4983225c&sid=14&en=0

Sep-28 12:40:06 PM

OS-Debug

SetIOMulti called for: OS-Station15, Command:0

Sep-28 12:40:06 PM

Device Control

Device: OpenSprinkler OpenSprinkler North Driveway Trees to Off (0) by/from: CAPI Control Handler

Sep-28 12:39:45 PM

OpenSprinkler

All zones are off

Sep-28 12:39:41 PM

OpenSprinkler

Zone 10 off successfully set

Sep-28 12:39:41 PM

OS-Debug

Debug Setter= {"result":1}

Sep-28 12:39:41 PM

OS-Debug

URL: /cm?pw=a6d82bced638de3def1e9bbb4983225c&sid=9&en=0

Sep-28 12:39:41 PM

OS-Debug

SetIOMulti called for: OS-Station10, Command:0

Sep-28 12:39:41 PM

Event

Deleting event after run: "Delayed Actions Master Driveway Trees (Delayed Action)"

Sep-28 12:39:41 PM

Device Control

Device: OpenSprinkler OpenSprinkler Master Driveway Trees to Off (0)

Sep-28 12:39:41 PM

Event

Event Trigger "Delayed Actions Master Driveway Trees (Delayed Action)"

Sep-28 12:37:56 PM

OpenSprinkler

Master Driveway Trees is currently on

Sep-28 12:37:56 PM

OS-Debug

Code Failed, Setter and result= ERROR: The operation has timed out. 0

Sep-28 12:37:56 PM

OS-Debug

Debug Setter= ERROR: The operation has timed out.

Sep-28 12:37:41 PM

OS-Debug

URL: /cm?pw=a6d82bced638de3def1e9bbb4983225c&sid=14&en=0

Sep-28 12:37:41 PM

OS-Debug

SetIOMulti called for: OS-Station15, Command:0

Sep-28 12:37:41 PM

Event

Deleting event after run: "Delayed Actions North Driveway Trees (Delayed Action) - 1"

Sep-28 12:37:41 PM

Device Control

Device: OpenSprinkler OpenSprinkler North Driveway Trees to Off (0)

Sep-28 12:37:41 PM

Event

Event Trigger "Delayed Actions North Driveway Trees (Delayed Action) - 1"

Sep-28 12:27:43 PM

OpenSprinkler

Master Driveway Trees and North Driveway Trees is currently on

Sep-28 12:27:41 PM

OpenSprinkler

Zone 15 on successfully set

Sep-28 12:27:41 PM

OS-Debug

Debug Setter= {"result":1}

Sep-28 12:27:41 PM

OS-Debug

SetIOMulti called for: OS-Station15, Command:361

Sep-28 12:27:41 PM

Event

Deleting event after run: "Delayed Actions North Driveway Trees (Delayed Action)"

Sep-28 12:27:41 PM

Device Control

Device: OpenSprinkler OpenSprinkler North Driveway Trees to On (361)

Sep-28 12:27:41 PM

Event

Event Trigger "Delayed Actions North Driveway Trees (Delayed Action)"

Sep-28 12:24:42 PM

OpenSprinkler

Master Driveway Trees is currently on

Sep-28 12:24:41 PM

OpenSprinkler

Zone 10 on successfully set

Sep-28 12:24:41 PM

OS-Debug

Debug Setter= {"result":1}

Sep-28 12:24:41 PM

OS-Debug

SetIOMulti called for: OS-Station10, Command:361

Sep-28 12:24:41 PM

Device Control

Device: OpenSprinkler OpenSprinkler Master Driveway Trees to On (361)

Sep-28 12:24:41 PM

Event

Event Trigger "Drip Driveway Trees Master On"

Sep-28 12:24:41 PM

Event

Event Drip Driveway Trees Master On triggered by the event page 'Run' button.

[Mattyjee]

I don't understand the message :If we got here, there's your problem!"

Rog

That comment was only relevant for the switching off, and that was when i was guessing what the problem was which it isnt.

Anyway, this is a tricky one, we will have to try it again. Attached is a new version, if you can do the same steps again - overwrite with this new version and send me the logs again. I think i know the offending line of code, but I need to see the value it was trying to work with, which i didn't have in my first debug code.

What i think is happening, if usually when HS writes a command to the OS using HTTP, it gets a response which looks like this: {"result":1} - i have some code which grabs the number and writes the translation to the log (eg. Zone 1 on successfully set), but if it doesnt get any response my code will fail as per what we are seeing - I think thats what's happening. If so, the real question is why your OS isn't responding to this particular command at this exact time. I also notice a 10 second delay between sending the command and getting the error - thats the timeout setting so it all fits - i have increased this to 15 for this debug version to see if this helps.

Cheers.

[rloeb]

Matt -- here's the log output:

Sep-27 12:35:03 PM OpenSprinkler All zones are off
Sep-27 12:35:00 PM OpenSprinkler Zone 10 off successfully set
Sep-27 12:35:00 PM OS-Debug URL: /cm?pw=a6d82bced638de3def1e9bbb4983225c&sid=9&en=0
Sep-27 12:35:00 PM OS-Debug Zonestring integer: 10, CC.Controlvalue: 0
Sep-27 12:35:00 PM OS-Debug Zonestring worked out to be10
Sep-27 12:35:00 PM OS-Debug Specific debug - we should have definitely got here
Sep-27 12:35:00 PM OS-Debug SetIOMulti called for: OS-Station10, Command:0
Sep-27 12:35:00 PM Event Deleting event after run: "Delayed Actions Master Driveway Trees (Delayed Action)"
Sep-27 12:35:00 PM Device Control Device: OpenSprinkler OpenSprinkler Master Driveway Trees to Off (0)
Sep-27 12:35:00 PM Event Event Trigger "Delayed Actions Master Driveway Trees (Delayed Action)"
Sep-27 12:33:10 PM OpenSprinkler Master Driveway Trees is currently on
Sep-27 12:33:10 PM OS-Plugin Failed to send out to Controller
Sep-27 12:33:10 PM OS-Debug SetIOMulti Exception - Input string was not in a correct format.
Sep-27 12:33:00 PM OS-Debug URL: /cm?pw=a6d82bced638de3def1e9bbb4983225c&sid=14&en=0
Sep-27 12:33:00 PM OS-Debug Zonestring integer: 15, CC.Controlvalue: 0
Sep-27 12:33:00 PM OS-Debug Zonestring worked out to be15
Sep-27 12:33:00 PM OS-Debug Specific debug - we should have definitely got here
Sep-27 12:33:00 PM OS-Debug SetIOMulti called for: OS-Station15, Command:0
Sep-27 12:33:00 PM Event Deleting event after run: "Delayed Actions North Driveway Trees (Delayed Action) - 1"
Sep-27 12:33:00 PM Device Control Device: OpenSprinkler OpenSprinkler North Driveway Trees to Off (0)
Sep-27 12:33:00 PM Event Event Trigger "Delayed Actions North Driveway Trees (Delayed Action) - 1"
Sep-27 12:17:27 PM OpenSprinkler Master Driveway Trees and North Driveway Trees is currently on
Sep-27 12:03:03 PM OpenSprinkler Master Driveway Trees and Drip: Grasses and North Driveway Trees is currently on
Sep-27 12:03:00 PM OpenSprinkler Zone 15 on successfully set
Sep-27 12:03:00 PM OS-Debug Seconds: 21660
Sep-27 12:03:00 PM OS-Debug If we got here, then theres your problem!
Sep-27 12:03:00 PM OS-Debug Zonestring integer: 15, CC.Controlvalue: 361
Sep-27 12:03:00 PM OS-Debug Zonestring worked out to be15
Sep-27 12:03:00 PM OS-Debug Specific debug - we should have definitely got here
Sep-27 12:03:00 PM OS-Debug SetIOMulti called for: OS-Station15, Command:361
Sep-27 12:03:00 PM Event Deleting event after run: "Delayed Actions North Driveway Trees (Delayed Action)"
Sep-27 12:03:00 PM Device Control Device: OpenSprinkler OpenSprinkler North Driveway Trees to On (361)
Sep-27 12:03:00 PM Event Event Trigger "Delayed Actions North Driveway Trees (Delayed Action)"
Sep-27 12:00:02 PM OpenSprinkler Master Driveway Trees and Drip: Grasses is currently on
Sep-27 12:00:00 PM OpenSprinkler Zone 10 on successfully set
Sep-27 12:00:00 PM OS-Debug Seconds: 21660
Sep-27 12:00:00 PM OS-Debug If we got here, then theres your problem!
Sep-27 12:00:00 PM OS-Debug Zonestring integer: 10, CC.Controlvalue: 361
Sep-27 12:00:00 PM OS-Debug Zonestring worked out to be10
Sep-27 12:00:00 PM OS-Debug Specific debug - we should have definitely got here
Sep-27 12:00:00 PM OS-Debug SetIOMulti called for: OS-Station10, Command:361
Sep-27 12:00:00 PM Device Control Device: OpenSprinkler OpenSprinkler Master Driveway Trees to On (361)
Sep-27 12:00:00 PM Event Event Trigger "Drip Driveway Trees Master On"

You will notice that the input strings to SetIOMulti are identical except for the station number. Note that turning a station on sets the run time to 6 hours, which is the HS default. The actual string sent by OpenSprinkler to the OSBee sets run time to one hour. "Off" sends a string that sets the run time to 0.

I don't understand the message :If we got here, there's your problem!"

Thank you for your very kind and generous assistance!

Rog

[Mattyjee]

My apologies, but I don't know how to install a plugin directly. (I'm running under Linux.)

Dammit, my post got deleted in the forum backup...

Anyway, sorry instructions are as follows:

1) There will already be a file called HSPI_Opensprinkler.exe in your C:\Program Files (x86)\Homeseer folder (or your linux equivalent).
2) Using the Homeseer web interface, manage tab, disable the Opensprinkler plugin.
3) Extract the zip file in my post #508 above, and overwrite the existing HSPI_Opensprinkler.exe with the new exe. Save a backup of the old file if you want to put it back after.
4) Re-enable the plugin as per step 2.
5) Test the issue again, and send me any log files you get.

Let me know if you need help on any of these steps.
Cheers.
Matt.

[rloeb]

My apologies, but I don't know how to install a plugin directly. (I'm running under Linux.)

[Mattyjee]

Rog,

Having searched my code, and your observation of it only fails when called through the events, not through the device view, I suspect that perhaps the "0" being sent is not a true zero but perhaps has a rounding error. I was unable to replicate the error on my system.

I've created a test file, which wont fix your problem but it includes a few extra log entries which will help me find the problem. Do you mind installing this over your current version and then sending me the same log - i should then be able to pinpoint the error.

Cheers.
Matt.

[rloeb]

Plugin Version 2.1.8.22; OS Version 2.1.7 on hardware 2.3-AC. Device is actually controlled via HTTP from OS, although HomeSeer doesn't know that. (It's connected to an OSBee.) What's interesting is that if I send an "off" command from the device view (by clicking "off" for that device), there's no problem.

Sep-22 11:15:22 AM

OpenSprinkler

Zone 15 off successfully set

Sep-22 11:15:22 AM

OS-Debug

SetIOMulti called for: OS-Station15, Command:0

Sep-22 11:15:22 AM

Device Control

Device: OpenSprinkler OpenSprinkler North Driveway Trees to Off (0) by/from: CAPI Control Handler

Rog

[Mattyjee]

Matt -- I'm getting a somewhat surprising error message and can't figure out what I'm doing wrong:

Sep-21 6:23:04 AM

OS-Plugin

Failed to send out to Controller

Sep-21 6:23:04 AM

OS-Debug

SetIOMulti Exception - Input string was not in a correct format.

Sep-21 6:23:00 AM

OS-Debug

SetIOMulti called for: OS-Station15, Command:0

Sep-21 6:23:00 AM

Event

Deleting event after run: "Delayed Actions North Driveway Trees (Delayed Action) - 1"

Sep-21 6:23:00 AM

Device Control

Device: OpenSprinkler OpenSprinkler North Driveway Trees to Off (0)

I don't control the format of the string. This is simply an event that turns a specific device on and, after a specified period, turns it off. There's a subsequent event that turns off a different station and it seems to work correctly.

Suggestions?

Rog

I'll take a look tomorrow. What firmware version and what plugin version are you using?

Cheers.

[rloeb]

Matt -- I'm getting a somewhat surprising error message and can't figure out what I'm doing wrong:

Sep-21 6:23:04 AM

OS-Plugin

Failed to send out to Controller

Sep-21 6:23:04 AM

OS-Debug

SetIOMulti Exception - Input string was not in a correct format.

Sep-21 6:23:00 AM

OS-Debug

SetIOMulti called for: OS-Station15, Command:0

Sep-21 6:23:00 AM

Event

Deleting event after run: "Delayed Actions North Driveway Trees (Delayed Action) - 1"

Sep-21 6:23:00 AM

Device Control

Device: OpenSprinkler OpenSprinkler North Driveway Trees to Off (0)

I don't control the format of the string. This is simply an event that turns a specific device on and, after a specified period, turns it off. There's a subsequent event that turns off a different station and it seems to work correctly.

Suggestions?

Rog

[Mattyjee]

hi matt
i noticed that when a station is qued. ie another station is already running & then you manually start another,
it shows the second station with the submitted run time, but it doesnt change status or color to indicate its qued.
in the IOS app, it shows it in a different color and that its scheduled.
this is just a nice to have if/when you are doing any updates - and assuming that its possible.

It is probably possible but its very difficult, so sorry I'll pass on this one.

[gregy]

hi matt
i noticed that when a station is qued. ie another station is already running & then you manually start another,
it shows the second station with the submitted run time, but it doesnt change status or color to indicate its qued.
in the IOS app, it shows it in a different color and that its scheduled.
this is just a nice to have if/when you are doing any updates - and assuming that its possible.

[ttbs922]

Interesting, I did have it set to 32, which is the number of zones on my system, but tried doubling it to 64 and it worked. Maybe it's because I am mixing hardware versions. Either way, I am working now, so thanks for the help!

[Mattyjee]

I recently noticed that this plugin was working again, so I ran the configuration to recreate all of my devices. It created the programs and the zones on the main board fine, but I can't get it to create the zones for my "zone expansion boards". I have an old version 8 zone as well as a new version 16 zone. My main board hardware is 2.0, firmware 2.1.7. Any help is appreciated.
Thanks

On the config page you have to set the number of stations. have you done this?

[Sleepy81]

Sleepy81 You can simplify it a bit like this:

hs.CAPIControlHandler(hs.CAPIGetSingleControl(2236, true, "15", false, true))

Thanks! I’ll try that tomorrow.

[ttbs922]

I recently noticed that this plugin was working again, so I ran the configuration to recreate all of my devices. It created the programs and the zones on the main board fine, but I can't get it to create the zones for my "zone expansion boards". I have an old version 8 zone as well as a new version 16 zone. My main board hardware is 2.0, firmware 2.1.7. Any help is appreciated.
Thanks