Salesforcedx-vscode: Unusually high java process CPU usage

Created on 18 Sep 2018  ·  47Comments  ·  Source: forcedotcom/salesforcedx-vscode

Summary

This seems to happen when using the extension to connect to a sandbox with a fairly big apex codebase (66% of total apex "space" used). But I'm not sure if it happens with smaller codebases.

I tried updating the plugin, but with no success. Not sure if it is out of pre-release already.

Steps To Reproduce:

  1. Create test class.
  2. Retrieve it.
  3. Deploy it.
  4. Process should be now eating ~300% of CPU resources.

screen shot 2018-09-18 at 11 53 03

screen shot 2018-09-18 at 11 53 16

Expected result

Java process to chew up a huge amount of CPU time only when running commands, like on extension start up, but then go back to not using that much CPU time, leaving Chrome to be the huge villain here.

Actual result

Java process chews up 200~400% of CPU % even when not being used, compared to the biggest monster I usually have running (Google Chrome) eating up to 40% of CPU %.

Additional information

The screenshot below shows how much the java process is keeping the CPU busy in my Macbook. The chart starts with the extension on idle (just VSCode open with 4 or 5 classes, not running anything, no big deal).

Then I proceed to close VSCode and kill the java process through Activity Monitor, and the blue lines go down completely. Then I proceed to open VSCode again with my project, and the chart goes crazy once more. It goes up on start up, and when running some command (like running tests or retrieving/deploying things). And then goes back to normal.

screen shot 2018-09-17 at 17 59 35

The thing is that at some point, when a certain command is executed, the java process seems to get stuck and unable to kill some background thread/process/task. The extension still works, but slowing my machine down.

Workaround

Close VSCode, kill the java process, and restart the editor.

VS Code Version:

1.27.2
f46c4c469d6e6d8c46f268d1553c5dc4b475840f
x64

SFDX CLI Version: "sfdx-cli/6.31.0-32aa4b4408 (darwin-x64) node-v8.9.4", with the plugin "salesforcedx 44.0.14 (pre-release)"

OS and version: macOS High Sierra 10.13.6 (17G65)

bug
Source
picture renatoliveira

Most helpful comment

We are actively working on the performance issue related to the Apex LSP and should have some fixes shortly. I'll update this thread once the fix is rolled out.

picture praksb on 17 Feb 2019
👍6 ❤1

All 47 comments

The output tab on VSCode shows lots of repeated lines of the same error after force quitting the java process through Activity Monitor:

[Error - 11:56:07 AM] Request textDocument/codeLens failed.
Error: Connection got disposed.
    at Object.dispose (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/renatoliveira/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.16.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
renatoliveira picture renatoliveira on 18 Sep 2018

This is unfortunate. We do need more details so we can reproduce. Are you able to do either of the following (in preferred order):

  1. Could you open a support ticket with Salesforce so that we can have log-in as access to your org to pull the source to reproduce this?
  2. Are you comfortable using Java tools (e.g., https://dzone.com/articles/how-to-take-thread-dumps-7-options) to capture the thread dumps for us so that we can take a closer look?
vazexqi picture vazexqi on 18 Sep 2018

If I understood correctly, using jstack takes thread dumps and automatically kills the process. If that's the case, then I'll update with the dump file as soon as I can get the issue to show up again.

The org in question is a customer's sandbox environment, which is being actively used as a development environment. Fortunately they have Premier Support. I'll raise the case with support, but what do I tell them? Or can I post the case number here with the dump?

renatoliveira picture renatoliveira on 18 Sep 2018

If you go with option 2, raise the case with support and then tell them to assign it to Platform Dev Tools (per the conversation here) — give them a link to this particular comment from _me_. I've done this before with https://github.com/forcedotcom/salesforcedx-vscode/issues/587#issuecomment-414707414

vazexqi picture vazexqi on 19 Sep 2018
👍3

@vazexqi I've raised a case with support. Case Number 20155542, and the dump is attached to it.

I've also noted that this issue seems to be unrelated to metadata retrieval or deployment. Seems to have started when I started typing code on the editor (and after a couple of minutes autocomplete was not working anymore, and the java process was stuck on 200%+ CPU usage).

Let me know if there's something else I can help with.

renatoliveira picture renatoliveira on 19 Sep 2018

@renatoliveira - I just got the case today and I'm trying to reproduce it. So far I've pulled down all the apex classes, apex triggers from your org.

I then tried the following:

  1. I tried to invoke code completion, code navigation, etc and I don't see any spikes in CPU.
  2. I tried to create a new simple test class _locally_ (I didn't push/deploy) and I don't see any spikes in CPU.

Here's what my process explorer look like from VS Code > Help > Open Process Explorer. Java is on the low CPU.

screen shot 2018-09-25 at 2 31 15 pm

Your repro steps mentioned

  1. Create test class. Where did you create this class?
  2. Retrieve it. Did you create the class from the server?
  3. Deploy it. I didn't do any deployments since I don't want to disrupt anything on your side
  4. Process should be now eating ~300% of CPU resources.
vazexqi picture vazexqi on 25 Sep 2018

So, it seems to be related to the code autocomplete feature when working with Apex. Creating, retrieving, deploying classes doesn't seem to trigger the issue.

The problem is that I couldn't find what exactly what triggers this when coding.

I'm not familiar with java debugging tools, but is there some way I can monitor what is happening, log it and send it to you? This way I can continue working, and when it happens again, I can send the log.

By the way, I have Java 1.8 (update 121) installed. Forgot to mention this, but who knows? This might be related.

renatoliveira picture renatoliveira on 26 Sep 2018

I had the exact same problem. I don't know exactly what this is but what I've noticed is that this occurred when trying to get code-completion suggestions. This caused the plugin to throw a really long error message (also containing all the code from within my currently edited file).

I think I got the problem to stop occurring, though. I just uninstalled Java and then reinstalled, and fortunately now it doesn't stay at 270+% usage. Although, this does not stop the plugin from using up 270+% of the CPU. In my case, my code base is really large, so I think this is why code-completion suggestions still cause CPU usage spikes, but at least it returns back to normal (see image below).

screen shot 2018-09-27 at 09 59 04

Hope this helps.

UPDATE: This didn't fix the issue.

So the error I get when the CPU Usage runs high is:

10:14:23.847 [ForkJoinPool.commonPool-worker-2] ERROR a.j.l.i.c.CodeLensesProviderAggregator - Encountered an error with code lens provider apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider@383dc82c
java.lang.IllegalArgumentException: expected one element but was:
<!-- The contents of the file it crashed in -->
at com.google.common.collect.Iterators.getOnlyElement(Iterators.java:316)
    at com.google.common.collect.Iterables.getOnlyElement(Iterables.java:254)
    at apex.jorje.lsp.api.utils.CodeUnits.getMatchingElement(CodeUnits.java:35)
    at apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider.lambda$provideCodeLenses$0(ApexTestRunCodeLensesProvider.java:88)
    at java.util.Optional.ifPresent(Optional.java:159)
    at apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider.provideCodeLenses(ApexTestRunCodeLensesProvider.java:86)
    at apex.jorje.lsp.impl.codeLens.CodeLensesProviderAggregator.lambda$provideCodeLenses$0(CodeLensesProviderAggregator.java:58)
    at java.lang.Iterable.forEach(Iterable.java:75)
    at apex.jorje.lsp.impl.codeLens.CodeLensesProviderAggregator.provideCodeLenses(CodeLensesProviderAggregator.java:56)
    at apex.jorje.lsp.impl.services.StandardTextDocumentService.lambda$codeLens$4(StandardTextDocumentService.java:181)
    at java.util.concurrent.CompletableFuture.uniApply(CompletableFuture.java:602)
    at java.util.concurrent.CompletableFuture$UniApply.tryFire(CompletableFuture.java:577)
    at java.util.concurrent.CompletableFuture$Completion.exec(CompletableFuture.java:443)
    at java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:289)
    at java.util.concurrent.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:1056)
    at java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1692)
    at java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:157)
[Info  - 12:51:57 PM] Connection to server got closed. Server will restart.
[Error - 12:51:57 PM] Request textDocument/definition failed.
Error: Connection got disposed.
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
[Error - 12:51:57 PM] Request textDocument/codeAction failed.
Error: Connection got disposed.
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
[Error - 12:51:57 PM] Request textDocument/codeAction failed.
Error: Connection got disposed.
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
[Error - 12:51:57 PM] Request textDocument/codeLens failed.
Error: Connection got disposed.
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
[Error - 12:51:57 PM] Request textDocument/codeAction failed.
Error: Connection got disposed.
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
[Error - 12:51:57 PM] Request textDocument/documentSymbol failed.
Error: Connection got disposed.
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
[Error - 12:51:57 PM] Request textDocument/codeAction failed.
Error: Connection got disposed.
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
[Error - 12:51:57 PM] Request textDocument/codeAction failed.
Error: Connection got disposed.
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
[Error - 12:51:57 PM] Request textDocument/codeAction failed.
Error: Connection got disposed.
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:825:25)
    at Object.dispose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:57:35)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1864:38)
    at LanguageClient.handleConnectionClosed (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/main.js:106:15)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-languageclient/lib/client.js:1852:18)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at closeHandler (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/main.js:221:26)
    at CallbackList.invoke (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:71:39)
    at Emitter.fire (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/events.js:135:36)
    at StreamMessageWriter.AbstractMessageWriter.fireClose (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:57:27)
    at Socket.<anonymous> (/Users/nicolaskadis/.vscode/extensions/salesforce.salesforcedx-vscode-apex-43.17.0/node_modules/vscode-jsonrpc/lib/messageWriter.js:79:63)
    at emitOne (events.js:116:13)
    at Socket.emit (events.js:211:7)
    at Pipe._handle.close [as _onclose] (net.js:554:12)
nkadis picture nkadis on 27 Sep 2018

This is the exact same error that I got @nkadis. I thought that all the messages were the same, but the first error on the stack is different from the other ones. Should've posted that before. Sorry about that!

renatoliveira picture renatoliveira on 27 Sep 2018
👍1

@nkadis — Your stack trace is a bit different but it at least shows a proper bug. When that bug occurs it took down the language server (hence all the connection lost logs). Since it’s a NullPointerException, we can guard against that in our ApexCodeLenseProvider.

~I am not sure if this would help @renatoliveira case but we can try this fix first.~

Update:

I thought that all the messages were the same, but the first error on the stack is different from the other ones

Oh, if this is the same then we might have a fix.

vazexqi picture vazexqi on 27 Sep 2018
👍1

Actually, looking more closely at the stacktrace

10:14:23.847 [ForkJoinPool.commonPool-worker-2] ERROR a.j.l.i.c.CodeLensesProviderAggregator - Encountered an error with code lens provider apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider@383dc82c
java.lang.IllegalArgumentException: expected one element but was:
<!-- The contents of the file it crashed in -->
at com.google.common.collect.Iterators.getOnlyElement(Iterators.java:316)
    at com.google.common.collect.Iterables.getOnlyElement(Iterables.java:254)
    at apex.jorje.lsp.api.utils.CodeUnits.getMatchingElement(CodeUnits.java:35)
    at apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider.lambda$provideCodeLenses$0(ApexTestRunCodeLensesProvider.java:88)
    at java.util.Optional.ifPresent(Optional.java:159)
    at apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider.provideCodeLenses(ApexTestRunCodeLensesProvider.java:86)
    at apex.jorje.lsp.impl.codeLens.CodeLensesProviderAggregator.lambda$provideCodeLenses$0(CodeLensesProviderAggregator.java:58)
    at java.lang.Iterable.forEach(Iterable.java:75)
    at apex.jorje.lsp.impl.codeLens.CodeLensesProviderAggregator.provideCodeLenses(CodeLensesProviderAggregator.java:56)
    at apex.jorje.lsp.impl.services.StandardTextDocumentService.lambda$codeLens$4(StandardTextDocumentService.java:181)
    at java.util.concurrent.CompletableFuture.uniApply(CompletableFuture.java:602)
    at java.util.concurrent.CompletableFuture$UniApply.tryFire(CompletableFuture.java:577)
    at java.util.concurrent.CompletableFuture$Completion.exec(CompletableFuture.java:443)
    at java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:289)
    at java.util.concurrent.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:1056)
    at java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1692)
    at java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:157)

// What happened between then and now?

[Info  - 12:51:57 PM] Connection to server got closed. Server will restart.

It seems that the IllegalArgumentException occurred at 10:14:23.847 whereas [Info - 12:51:57 PM] Connection to server got closed. Server will restart happened almost 3 hours later.

The Connection to server got closed is the actual culprit. Do you have an idea of what you were doing? I have some theories:

  1. Did you do a git clean -xfd on that project?
  2. Did you manually delete the files in the .sfdx/ folder on that project?
  3. Did you open multiple instances of VS code on the same project?
  4. Did the laptop go into sleep mode?
vazexqi picture vazexqi on 27 Sep 2018

I can guarantee that I didn't do 1, 2 and 3. Number 4 is possible, however. But I did face this issue even when the laptop didn't go into sleep mode.

I've been working with Lightning Components mostly since then, so I haven't faced this issue anymore to check. Today I wrote some classes and tests, but didn't see this issue happening again.

renatoliveira picture renatoliveira on 28 Sep 2018

// What happened between then and now?

I believe that the Connection to server got closed error occurred when I force quit java from Activity Monitor. I did this to stop the cpu from getting fried.

  1. Did you do a git clean -xfd on that project?

No

  1. Did you manually delete the files in the .sfdx/ folder on that project?

The only thing I removed from the .sfdx folder is .sfdx/tools/apex.db as per the Troobleshooting section on Apex Code Editor for Visual Studio Code.

If you’re not seeing the Apex completion suggestions that you expect, your Apex database might need to be rebuilt. Quit VS Code, and then delete the .sfdx/tools/apex.db file from your project. Then relaunch VS Code, and open an Apex class or trigger. The Apex database rebuilds within about 5 seconds (up to 30 seconds for very large code bases).

  1. Did you open multiple instances of VS code on the same project?

No

  1. Did the laptop go into sleep mode?

No

nkadis picture nkadis on 28 Sep 2018

Any updates on this?

nkadis picture nkadis on 13 Nov 2018

I'm also experiencing this problem. Although it seems to be related to the autocompletion apex code feature in my case. Hoping it's going to be of some help I attach the process dump contents of the process that more than a few times goes out of control.

dump.txt

shillem picture shillem on 29 Nov 2018

It seems to me that the problem is triggered while the outline pane is opened.
If the outline pane is collapsed, no hangs. It's been 2 days now without one, whereas before it was guaranteed it would happen sooner or later.

shillem picture shillem on 3 Jan 2019
👍2

I'm also experiencing this error. It seems to effect autocompletion, it does not cause application hang (windows). I've tried refreshing sObject Definitions, deleting Apex.db and restarting vscode

[ForkJoinPool.commonPool-worker-0] ERROR a.j.l.i.c.CodeLensesProviderAggregator - Encountered an error with code lens provider apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider@35b74c5c
java.lang.IllegalArgumentException: expected one element but was: <File Contents here>
    at com.google.common.collect.Iterators.getOnlyElement(Iterators.java:316)
    at com.google.common.collect.Iterables.getOnlyElement(Iterables.java:254)
    at apex.jorje.lsp.api.utils.CodeUnits.getMatchingElement(CodeUnits.java:35)
    at apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider.lambda$provideCodeLenses$0(ApexTestRunCodeLensesProvider.java:88)
    at java.util.Optional.ifPresent(Optional.java:159)
    at apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider.provideCodeLenses(ApexTestRunCodeLensesProvider.java:86)
    at apex.jorje.lsp.impl.codeLens.CodeLensesProviderAggregator.lambda$provideCodeLenses$0(CodeLensesProviderAggregator.java:58)
    at java.lang.Iterable.forEach(Iterable.java:75)
    at apex.jorje.lsp.impl.codeLens.CodeLensesProviderAggregator.provideCodeLenses(CodeLensesProviderAggregator.java:56)
    at apex.jorje.lsp.impl.services.StandardTextDocumentService.lambda$codeLens$7(StandardTextDocumentService.java:186)
    at java.util.concurrent.CompletableFuture.uniApply(CompletableFuture.java:602)
    at java.util.concurrent.CompletableFuture$UniApply.tryFire(CompletableFuture.java:577)
    at java.util.concurrent.CompletableFuture$Completion.exec(CompletableFuture.java:443)
    at java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:289)
    at java.util.concurrent.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:1056)
    at java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1692)
    at java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:157)
andrewhorwood picture andrewhorwood on 28 Jan 2019

@ntotten I see that you have removed the "in gus" label and also added this issue to the Spring 19 milestone. So it looks like we can expect a fix on the very next Salesforce release, right? 🙏

renatoliveira picture renatoliveira on 28 Jan 2019

We are working on a fix for this one as well as working on adding support for OpenJDK 11. We aren't tied to Salesforce releases so the timeline isn't exact. We use those release for planning, but we ship features/fixes whenever they are ready in our weekly releases.

Regarding the "in-gus" tag, we just stopped using that so that doesn't mean anything. :)

ntotten picture ntotten on 28 Jan 2019

Oh? I thought the releases were in sync with the platform's.

Great to know that #398 will be addressed as well.

Good job! 👍

renatoliveira picture renatoliveira on 28 Jan 2019

I have similar issue. In my project I have around ~300 apex classes, 150 objects etc. The code completion works very slow. After several attempt it stops working and CPU usage increases a lot.

In the Output pane for Apex Language Server I can see the following error:

21:11:44.428 [Apex Prelude Service STARTING] INFO a.j.l.i.s.ApexPreludeManagedService - Scanning built-in and system Apex types.
Jan 28, 2019 9:11:46 PM apex.jorje.parser.impl.BaseApexLexer dedupe
INFO: Deduped array ApexLexer.DFA22_transition. Found 7272051 shorts which is 13MB not including array overhead. Removed 6615472 shorts which is 12MB not counting array overhead. Took 39 ms.
21:11:54.307 [Apex Prelude Service STARTING] INFO a.j.l.i.s.ApexPreludeManagedService - Patching standard library for System.Database.* methods
21:11:54.340 [Apex Prelude Service STARTING] INFO a.j.l.i.s.ApexPreludeManagedService - Done patching standard library for System.Database.* methods
21:11:56.431 [ApexIndexer STARTING] INFO a.jorje.lsp.impl.index.ApexIndexer - Scanning user-defined types.
21:11:56.430 [Apex Prelude Service STARTING] INFO a.j.l.i.s.ApexPreludeManagedService - Scanning built-in and system Apex types took 12004 ms.
Jan 28, 2019 9:12:10 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 11
21:12:10.614 [ForkJoinPool.commonPool-worker-3] ERROR a.j.l.i.c.CodeLensesProviderAggregator - Encountered an error with code lens provider apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider@2e570ded
java.lang.IllegalArgumentException: expected one element but was:

...

>
at com.google.common.collect.Iterators.getOnlyElement(Iterators.java:316)
at com.google.common.collect.Iterables.getOnlyElement(Iterables.java:254)
at apex.jorje.lsp.api.utils.CodeUnits.getMatchingElement(CodeUnits.java:35)
at apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider.lambda$provideCodeLenses$0(ApexTestRunCodeLensesProvider.java:88)
at java.util.Optional.ifPresent(Optional.java:159)
at apex.jorje.lsp.impl.codeLens.ApexTestRunCodeLensesProvider.provideCodeLenses(ApexTestRunCodeLensesProvider.java:86)
at apex.jorje.lsp.impl.codeLens.CodeLensesProviderAggregator.lambda$provideCodeLenses$0(CodeLensesProviderAggregator.java:58)
at java.lang.Iterable.forEach(Iterable.java:75)
at apex.jorje.lsp.impl.codeLens.CodeLensesProviderAggregator.provideCodeLenses(CodeLensesProviderAggregator.java:56)
at apex.jorje.lsp.impl.services.StandardTextDocumentService.lambda$codeLens$7(StandardTextDocumentService.java:186)
at java.util.concurrent.CompletableFuture.uniApply(CompletableFuture.java:602)
at java.util.concurrent.CompletableFuture$UniApply.tryFire(CompletableFuture.java:577)
at java.util.concurrent.CompletableFuture$Completion.exec(CompletableFuture.java:443)
at java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:289)
at java.util.concurrent.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:1056)
at java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1692)
at java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:157)

21:12:58.748 [ApexIndexer STARTING] INFO a.jorje.lsp.impl.index.ApexIndexer - Scanning user-defined types took 62315 ms.
Jan 28, 2019 9:16:59 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation

steals picture steals on 28 Jan 2019

Hi again,

I think I got some new info, maybe this could help in debugging the issue.

This happened to me when I cmd + click on an existing method I call from another class, which would normally take me to the declaration of that method. Instead, I get this:

12:35:36.403 [Apex Prelude Service STARTING] INFO  a.j.l.i.s.ApexPreludeManagedService - Scanning built-in and system Apex types.
Jan 29, 2019 12:35:37 PM apex.jorje.parser.impl.BaseApexLexer dedupe
INFO: Deduped array ApexLexer.DFA22_transition. Found 7272051 shorts which is 13MB not including array overhead. Removed 6615472 shorts which is 12MB not counting array overhead. Took 33 ms.
12:35:40.999 [Apex Prelude Service STARTING] INFO  a.j.l.i.s.ApexPreludeManagedService - Patching standard library for System.Database.* methods
12:35:41.007 [Apex Prelude Service STARTING] INFO  a.j.l.i.s.ApexPreludeManagedService - Done patching standard library for System.Database.* methods
12:35:42.547 [ApexIndexer STARTING] INFO  a.jorje.lsp.impl.index.ApexIndexer - Scanning user-defined types.
12:35:42.546 [Apex Prelude Service STARTING] INFO  a.j.l.i.s.ApexPreludeManagedService - Scanning built-in and system Apex types took 6144 ms.
12:36:43.280 [ApexIndexer STARTING] INFO  a.jorje.lsp.impl.index.ApexIndexer - Scanning user-defined types took 60731 ms.
Jan 29, 2019 12:42:42 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 34
Jan 29, 2019 12:42:54 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 53
Jan 29, 2019 12:42:55 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 54
Jan 29, 2019 12:43:19 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 64
Jan 29, 2019 12:43:19 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 65
Jan 29, 2019 12:43:19 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 69
Jan 29, 2019 12:43:19 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 70
Jan 29, 2019 12:43:19 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 71
Jan 29, 2019 12:43:19 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 72
Jan 29, 2019 12:43:19 PM org.eclipse.lsp4j.jsonrpc.RemoteEndpoint handleCancellation
WARNING: Unmatched cancel notification for request id 76

And I assume this would go on until the laptop gets fried

Now to stop this, what I used to do was just force stop the java process that was using up all that cpu, which would basically make the extension stop working. But now, when I do that I get this error, which restarts the process and tries to burn my laptop again (until I restart vscode that is):

[Info  - 12:43:48 PM] Connection to server got closed. Server will restart.
12:44:00.490 [Apex Prelude Service STARTING] INFO  a.j.l.i.s.ApexPreludeManagedService - Scanning built-in and system Apex types.
Jan 29, 2019 12:44:00 PM apex.jorje.parser.impl.BaseApexLexer dedupe
INFO: Deduped array ApexLexer.DFA22_transition. Found 7272051 shorts which is 13MB not including array overhead. Removed 6615472 shorts which is 12MB not counting array overhead. Took 37 ms.
12:44:07.876 [ApexIndexer STARTING] INFO  a.jorje.lsp.impl.index.ApexIndexer - Scanning user-defined types.
12:44:07.876 [Apex Prelude Service STARTING] INFO  a.j.l.i.s.ApexPreludeManagedService - Scanning built-in and system Apex types took 7386 ms.

Anyway, from what I understand, this doesn't have to do with either the outline, or the autocomplete, or any other feature. My best guess is that there is an issue with the way you guy might be handling large files or something.

Hope this helps :)

nkadis picture nkadis on 29 Jan 2019

Oh and something else I noticed, is that when this issue occurs and I close vs code, the java process doesn't terminate, only the parent process. If you have a look at the image attached, the parent process is null, but before closing vs code, that process linked the the parent vscode process. Shouldn't this terminate since it's a child process?

screenshot 2019-01-29 at 15 32 03

nkadis picture nkadis on 29 Jan 2019
👍2

I have similar issue. I'm working on a large sandbox. Whenever I try to retrieve source from manifest with the package.xml - VSCode crushes and I'll get the "out of application memory" error.

sfdx-cli/6.50.0-9817aece8a (darwin-x64) node-v8.9.4
MacOS Mojave 10.14.2 / 16GB RAM

Aviad211 picture Aviad211 on 30 Jan 2019

I am also seeing this

mfrenchlitify picture mfrenchlitify on 7 Feb 2019

Having the same issue

paul-drozd-itechart picture paul-drozd-itechart on 11 Feb 2019

I have the same issue.

gswinarski picture gswinarski on 14 Feb 2019

I can confirm that this is a huge issue for me . The memory consumption went as high as 2GB . I have an org with 100 apex classes atleast and my computer ran out of memory .If there is anything that we could help will be happy to help with .Thanks

msrivastav13 picture msrivastav13 on 17 Feb 2019

I also have this issue. I have seen the memory consumption as high as 4GB and generally I will wind up just killing the apex language server java process when I am writing apex in vscode :|

mtetlow picture mtetlow on 17 Feb 2019

I would prefer not to have auto complete than consuming my computer memory .How do you kill the language server ?

msrivastav13 picture msrivastav13 on 17 Feb 2019

I used to be able to kill the java process in the os x activity monitor... but it looks like now it is restarting the java process. I swear this worked a few weeks ago

mtetlow picture mtetlow on 17 Feb 2019
👍1

@msrivastav13 You can disable APEX LSP and all related staff by removing the salesforcedx-vscode-apex.java.home setting from User settings in vscode

steals picture steals on 17 Feb 2019
👍2

We are actively working on the performance issue related to the Apex LSP and should have some fixes shortly. I'll update this thread once the fix is rolled out.

praksb picture praksb on 17 Feb 2019
👍6 ❤1

Have the same issue. CPU raise up to 330%

daniil-rozin-itechart picture daniil-rozin-itechart on 21 Feb 2019

We have made some improvements to Apex LSP performance in our latest extension update. Can you all please update to the latest Apex extension (v45.3.0) and let us know if you still have any performance issues? Please open a new github issue if you still see any perf related problems.

https://github.com/forcedotcom/salesforcedx-vscode/pull/1092

praksb picture praksb on 22 Feb 2019

This issue is still occurring. Running Apex extension v45.3.0

Jody-CS picture Jody-CS on 7 Mar 2019

@Jody-CS Can you please update to version v45.5.0 and let us know if you still see this problem? We made some more recent fixes.

praksb picture praksb on 7 Mar 2019
👍1

This issue still occurs on the version v45.15.1. Java process almost at 3GB. JDK version jdk1.8.0_211, here my specs:

image

matteobosc picture matteobosc on 23 May 2019

@matteobosc When you load your project after starting VS Code, the Apex LSP tries to index your apex classes and triggers. Currently, it does take up a good chunk of memory since it loads all the source files in memory. This could be an issue if your org is very large. We are working on making this experience better.

praksb picture praksb on 23 May 2019

Hi @praksb, yes, my org is pretty large, but the CPU time is stuck on that Java process even after hours I loaded VSC. Hope this will be improved, thanks in advance for your work!

matteobosc picture matteobosc on 25 May 2019

I also seeing this when working with a large sandbox.
I'm Using OpenJDK 8.
I try to set "autoCompile" to _false_ in _.forceCode/_ but still not helping.

I found the problem was caused by the attempt to launch the apex language server.
I manually terminated the java SE 5 times then the message below was showed and
cpu usage goes down.

[Info  - 12:07:28] Connection to server got closed. Server will restart.
[Info  - 12:07:29] Connection to server got closed. Server will restart.
[Info  - 12:07:30] Connection to server got closed. Server will restart.
[Info  - 12:07:31] Connection to server got closed. Server will restart.
[Error - 12:07:32] Connection to server got closed. Server will not be restarted.
jxzhangxing picture jxzhangxing on 29 Aug 2019

I am also running into this issue where the Java process is using a large chunk of memory.

image

Just over 2.5GB of memory and I only have 200 Apex Classes which totals to 2.6MB of source files (whole project adds up to just over 40MB in size). I am not experiencing any user experience issues but this process shouldn't be using this much memory.

No errors logged in the Output window. Screenshot taken after loading project into VSCode with no Apex Classes open.
OS: Windows 10 1903

SaoBiz picture SaoBiz on 30 Aug 2019

Which Java version are you using? I stopped seeing this issue a while ago, and it never happened again. I'm on OpenJDK 11 now, by the way.

renatoliveira picture renatoliveira on 30 Aug 2019

Hi everyone, this week I've started to have this issue, I tried different version of Java JDK but unfortunately the issue happens in all them, could someone help me on it? Thanks

image

magaiverf picture magaiverf on 5 Jun 2020

any progress? This issue is still occurring.

402332509 picture 402332509 on 4 Aug 2020

I also have a fairly small org that I'm working with, and I'm getting super high RAM and CPU usage as well. They seem to fluctuate, when one is low the other is high.

image

image

johnpanos picture johnpanos on 11 Aug 2020

I am also seeing this old nasty bug. Mac 10.15.6 | VSCode 1.47.3 | Salesforce Ext Pack 49.4.0

Jody-CS picture Jody-CS on 11 Aug 2020
👍3
Was this page helpful?
0 / 5 - 0 ratings

Related issues

randi274 picture randi274  ·  3Comments
frackham picture frackham  ·  6Comments
SalesforceBobLightning picture SalesforceBobLightning  ·  5Comments
sc5148 picture sc5148  ·  4Comments
Shokhan picture Shokhan  ·  6Comments