OH2.4 VScode error when coding

Max_G · October 20, 2019, 1:06am

I am running VScode on Windows 10, with OH2.4.0 running on a rPi3

When I am updating rule files (which do not show any errors and run fine), I get the error below.
I have no clue as to what it means.
Can it be switched off, as it pops up in the bottom of the screen reducing my editor window, which is more of a nuisance than help.

[Error - 10:41:40] Request textDocument/definition failed.
  Message: Internal error.
  Code: -32603 
java.util.concurrent.CompletionException: java.lang.RuntimeException: Cannot create a resource for 'java:/Objects/org.eclipse.smarthome.model.script.actions.LogAction'; a registered resource factory is needed
	at java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:292)
	at java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:308)
	at java.util.concurrent.CompletableFuture.uniAccept(CompletableFuture.java:647)
	at java.util.concurrent.CompletableFuture$UniAccept.tryFire(CompletableFuture.java:632)
	at java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:474)
	at java.util.concurrent.CompletableFuture.completeExceptionally(CompletableFuture.java:1977)
	at org.eclipse.xtext.ide.server.concurrent.ReadRequest.lambda$run$0(ReadRequest.java:43)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: Cannot create a resource for 'java:/Objects/org.eclipse.smarthome.model.script.actions.LogAction'; a registered resource factory is needed

[edit] HAd a look at this [SOLVED] Item refreshes state very quickly but cannot see any relationship. It also happens with any rule file.
My rule files parse w/o errors.

Confectrician · October 20, 2019, 6:37am

The error tells something about LogActions that were not able to be completed.

Do you use logging and if yes can you paste one of the rules where you use it?

Max_G · October 25, 2019, 10:07am

I use logging probably in its simplest form:

logInfo("rule step", "... blah set to {}", blah.state)

or

logInfo("rule step", "... blah set to x")

A rule I use logging…

rule "Start Irrigation1"
	when
		// triggers to start this group; either auto (by cron) or manual
		Item Irrigation1_Auto changed to ON or
		Item Irrigation1_Now  changed to ON
	then
		// only irrigate if allowed is ON
		if (Irrigation1_Allowed.state == ON) {

			// start up valve 1 of 4
			logInfo("Irrigation1.10", "Irrigation1 started...")

			// capture current meter (from last session) and store it in last session total
			logInfo("Irrigation1.11a", "... PumpStation1_LastSessionTotal set to {}", PumpStation1_LastSessionTotal.state)
			PumpStation1_LastSessionTotal.postUpdate(PumpStation1_LastSessionMemory.state)
			logInfo("Irrigation1.11b", "... PumpStation1_LastSessionTotal set to {}", PumpStation1_LastSessionTotal.state)

			// zero the last session memory and start at zero for this session
			logInfo("Irrigation1.11c", "... PumpStation1_LastSessionMemory -> to {}", PumpStation1_LastSessionMemory.state)
			PumpStation1_LastSessionMemory.postUpdate(0)
			logInfo("Irrigation1.11d", "... PumpStation1_LastSessionMemory -> to {}", PumpStation1_LastSessionMemory.state)

			// ----- reset meter to 0 for good...
			// reset the controller's meter to 0
			publish("mymosquitto", "ArgyleCourt/Property/PumpStation1/Command", "resetMeter")
			publish("mymosquitto", "ArgyleCourt/Property/PumpStation1/Meter", "0")

			// we now have to update this value as well, because the controller does
			//   not publish back the forced change to 0
			PumpStation1_Meter.postUpdate(0)

			// reset the session volume counter to zero
			logInfo("Irrigation1.13b", "... PumpStation1_Meter .......... set to 0 -> {}", PumpStation1_Meter.state)
			logInfo("Irrigation1.14a", "... PumpStation1 VolumeSession .. set to {}", PumpStation1_MemoriseMeterRead)
			PumpStation1_MemoriseMeterRead = (PumpStation1_Meter.state as Number).intValue
			logInfo("Irrigation1.14", "... PumpStation1 VolumeSession ... set to 0; is it? -> {}", PumpStation1_MemoriseMeterRead)

			// update 'curr'ent valve name; which is #1
			Irrigation1_Curr.sendCommand(Irrigation1_1.name)

			// now switch valve 1 ON
			Irrigation1_1.sendCommand(ON)
			logInfo("Irrigation1.15", "..> turning ............................ Irrigation1_1 ON")

		} else {

			logInfo("Irrigation1.16", "Irrigation1 not started -> not allowed!")
			Irrigation1_Reset.postUpdate(ON)
		}
end

rossko57 · October 25, 2019, 9:03pm

I think you’ve got some kind of debug mode enabled? The logfile it cannot create is on the local/editing machine and not the remote host?

Max_G · October 25, 2019, 11:08pm

Haven’t changed anything related to logging other than this rule, which logs to a file:

			// logging relay controller reboots
			val String errMsg = now.toString + " " + Shed_RC41_Message.state.toString.replace('|', '_')
			val String errCmd = executeCommandLine("/bin/sh@@-c@@echo " + errMsg + " >> /etc/openhab2/html/RelayController41.txt; echo $?", 3000)

and this in the Thing file

Thing logreader:reader:openhablog [ refreshRate=10000, errorPatterns="ERROR+" ]

which OH can write to as can be seen int he log file it adds to:

2019-10-16T19:16:37.128+10:00 Arduino_RelayController41_INFO_has rebooted
2019-10-17T13:15:28.608+10:00 Arduino_RelayController41_INFO_has rebooted
2019-10-19T13:15:18.538+10:00 Arduino_RelayController41_INFO_has rebooted
2019-10-19T13:15:37.410+10:00 Arduino_RelayController41_INFO_has rebooted

rossko57 · October 25, 2019, 11:56pm

What I’m trying to say is this is a VSCode problem, not your running openHAB. VSCode is trying to create or access some log file - I’ll have a guess VSC has tried to execute your rule locally due to some debug setting, and/or it’s trying to access a remote logfile.

I don’t know how any of this stuff works. I do not have an “openHAB server” option in the dropdown selector for my debug ‘output’ tab. To the right of that is a ‘clear’ button, but I guess the message comes back?

detond09 · January 5, 2020, 3:42pm

any update on this?
I am having the same problem… with OH 2.5 and VSCode 0.6

Confectrician · January 5, 2020, 3:46pm

Please post a screenshot of your error message.

Confectrician · January 5, 2020, 3:55pm

I seem to have missed that las post, so i will give a really late answer.

Nope.
VsCode (or at least the openHAB extension) doesn’t execute/debug rules.
It also doesn’t access log files in the background.

The openHAB server Output Tab is generated from the remote LSP server connection.
If remote LSP is disabled, the corresponding Output tab isn’t activated.

So here are the short facts:

The error message is generated from remote lsp server in your openHAB environment.
It then gets delivered via lsp conenction into the remote lsp client module
The remote lsp client itself then adds this message to the openHAB server output.

So the error is somehow thrown while checking the rule via lsp.
@wborn you have something with lsp a while ago.
Maybe you have an idea about this error and how we can dig into solving it or whats the server side cause for throwing it.

wborn · January 5, 2020, 4:29pm

I haven’t been annoyed enough by it to further investigate this.