eclipse-jdtls / eclipse.jdt.ls

Java language server
1.79k stars 399 forks source link

extremely slow response to completion or signature help request in lambda defined in enum #1640

Closed puremourning closed 1 year ago

puremourning commented 3 years ago

Summary

When requesting completion or signature help within a lambda declared as part of an enum item, the request thread spins for a long time, and the client gets no response

Sorry for the cryptic title, the scenario this happens in is quite specific, but the result is a java thread in jdt.ls pegging a CPU for a very long time. Each subsequent request adds another spinning thread.

Edit: Initially I thought it was "forever" but in the minimal case, the the thread does stop spinning at some point (though on a larger project this point has not been reached yet!)

Reproduction

Use the following:

package com.youcompleteme;

import java.util.Arrays;
import java.util.List;

public class TestEnum {
  public interface FirstOperation {
    public void op( String str, char b );
  }
  public interface SecondOperation {
    public void op( StringBuilder b, List<String> sl );
  }

  enum ThisIsTheEnum {
    FIRST(

        ( str, b ) -> {

        },

        ( b, sl ) -> {

        }

    ) ;

    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {
      this.f = f;
      this.s = s;
    }

    public void DoIt() {
      this.f.op( "test", 'b' );
      this.s.op( new StringBuilder(), Arrays.asList() );
    }

    private FirstOperation f;
    private SecondOperation s;
  }
}

Then in the definition of FIRST, make a request for something like this:

        ( str, b ) -> {

            if ( str.indexOf(

        },

(the requests are a completion request for str. and the signature help for indexOf().

Note:

At this point the java process associated with jdt.ls consumes one CPU. Repeating the signature help request makes it use 2 CPUs etc.

In the minimal repro case, this carries on for some time, but then the thread does seem to exit. On moderate sized project, the thread spins for a very long time.

Here's the stack captured from a larger project:

CAUTION: [EXTERNAL Email]

2021-01-08 17:15:06
Full thread dump OpenJDK 64-Bit Server VM (11.0.3+7-LTS mixed mode, sharing):

Threads class SMR info:
_java_thread_list=0x00007f3548001c70, length=26, elements={
0x00007f35d8013000, 0x00007f35d84bc000, 0x00007f35d84be000, 0x00007f35d84c3800,
0x00007f35d84c6000, 0x00007f35d84d0000, 0x00007f35d84d2000, 0x00007f35d8508800,
0x00007f35d850d000, 0x00007f35d85b5800, 0x00007f35d8743800, 0x00007f35d8772800,
0x00007f35d8790800, 0x00007f350802f800, 0x00007f35081d5000, 0x00007f34ec001000,
0x00007f35084ee000, 0x00007f350880d800, 0x00007f35d87a7000, 0x00007f35d884f000,
0x00007f34f4031800, 0x00007f3474063800, 0x00007f35411d2800, 0x00007f35443fa800,
0x00007f3478346000, 0x00007f3548001000
}

"main" #1 prio=5 os_prio=0 cpu=893.10ms elapsed=1639.06s tid=0x00007f35d8013000 nid=0x154e in Object.wait()  [0x00007f35e1054000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <0x000000008291ce00> (a java.lang.Object)
        at java.lang.Object.wait(java.base@11.0.3/Object.java:328)
        at org.eclipse.jdt.ls.core.internal.LanguageServer.start(LanguageServer.java:33)
        - waiting to re-lock in wait() <0x000000008291ce00> (a java.lang.Object)
        at org.eclipse.equinox.internal.app.EclipseAppHandle.run(EclipseAppHandle.java:203)
        at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.runApplication(EclipseAppLauncher.java:134)
        at org.eclipse.core.runtime.internal.adaptor.EclipseAppLauncher.start(EclipseAppLauncher.java:104)
        at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:401)
        at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:255)
        at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@11.0.3/Native Method)
        at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@11.0.3/NativeMethodAccessorImpl.java:62)
        at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@11.0.3/DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(java.base@11.0.3/Method.java:566)
        at org.eclipse.equinox.launcher.Main.invokeFramework(Main.java:653)
        at org.eclipse.equinox.launcher.Main.basicRun(Main.java:590)
        at org.eclipse.equinox.launcher.Main.run(Main.java:1461)
        at org.eclipse.equinox.launcher.Main.main(Main.java:1434)

"Reference Handler" #2 daemon prio=10 os_prio=0 cpu=1.59ms elapsed=1639.03s tid=0x00007f35d84bc000 nid=0x1555 waiting on condition  [0x00007f356c568000]
   java.lang.Thread.State: RUNNABLE
        at java.lang.ref.Reference.waitForReferencePendingList(java.base@11.0.3/Native Method)
        at java.lang.ref.Reference.processPendingReferences(java.base@11.0.3/Reference.java:241)
        at java.lang.ref.Reference$ReferenceHandler.run(java.base@11.0.3/Reference.java:213)

"Finalizer" #3 daemon prio=8 os_prio=0 cpu=0.38ms elapsed=1639.03s tid=0x00007f35d84be000 nid=0x1556 in Object.wait()  [0x00007f356c467000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <0x00000000820045c8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(java.base@11.0.3/ReferenceQueue.java:155)
        - waiting to re-lock in wait() <0x00000000820045c8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(java.base@11.0.3/ReferenceQueue.java:176)
        at java.lang.ref.Finalizer$FinalizerThread.run(java.base@11.0.3/Finalizer.java:170)

"Signal Dispatcher" #4 daemon prio=9 os_prio=0 cpu=0.41ms elapsed=1639.03s tid=0x00007f35d84c3800 nid=0x1557 runnable  [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread0" #5 daemon prio=9 os_prio=0 cpu=11371.83ms elapsed=1639.03s tid=0x00007f35d84c6000 nid=0x1558 waiting on condition  [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"C1 CompilerThread0" #15 daemon prio=9 os_prio=0 cpu=2332.83ms elapsed=1639.03s tid=0x00007f35d84d0000 nid=0x1559 waiting on condition  [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"Sweeper thread" #20 daemon prio=9 os_prio=0 cpu=407.08ms elapsed=1639.03s tid=0x00007f35d84d2000 nid=0x155a runnable  [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Service Thread" #21 daemon prio=9 os_prio=0 cpu=0.07ms elapsed=1639.00s tid=0x00007f35d8508800 nid=0x155d runnable  [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Common-Cleaner" #22 daemon prio=8 os_prio=0 cpu=2.65ms elapsed=1639.00s tid=0x00007f35d850d000 nid=0x155f in Object.wait()  [0x00007f354d6cf000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <no object reference available>
        at java.lang.ref.ReferenceQueue.remove(java.base@11.0.3/ReferenceQueue.java:155)
        - waiting to re-lock in wait() <0x0000000082003db8> (a java.lang.ref.ReferenceQueue$Lock)
        at jdk.internal.ref.CleanerImpl.run(java.base@11.0.3/CleanerImpl.java:148)
        at java.lang.Thread.run(java.base@11.0.3/Thread.java:834)
        at jdk.internal.misc.InnocuousThread.run(java.base@11.0.3/InnocuousThread.java:134)

"process reaper" #24 daemon prio=10 os_prio=0 cpu=46.74ms elapsed=1638.84s tid=0x00007f35d85b5800 nid=0x1561 waiting on condition  [0x00007f35e0ee9000]
   java.lang.Thread.State: TIMED_WAITING (parking)
        at jdk.internal.misc.Unsafe.park(java.base@11.0.3/Native Method)
        - parking to wait for  <0x0000000082005a70> (a java.util.concurrent.SynchronousQueue$TransferStack)
        at java.util.concurrent.locks.LockSupport.parkNanos(java.base@11.0.3/LockSupport.java:234)
        at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(java.base@11.0.3/SynchronousQueue.java:462)
        at java.util.concurrent.SynchronousQueue$TransferStack.transfer(java.base@11.0.3/SynchronousQueue.java:361)
        at java.util.concurrent.SynchronousQueue.poll(java.base@11.0.3/SynchronousQueue.java:937)
        at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@11.0.3/ThreadPoolExecutor.java:1053)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@11.0.3/ThreadPoolExecutor.java:1114)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@11.0.3/ThreadPoolExecutor.java:628)
        at java.lang.Thread.run(java.base@11.0.3/Thread.java:834)

"Active Thread: Equinox Container: 8d9edbdc-ed67-46a6-9112-292e1c50c8c1" #25 prio=5 os_prio=0 cpu=10.84ms elapsed=1638.39s tid=0x00007f35d8743800 nid=0x156c waiting on condition  [0x00007f354cea1000]
   java.lang.Thread.State: TIMED_WAITING (parking)
        at jdk.internal.misc.Unsafe.park(java.base@11.0.3/Native Method)
        - parking to wait for  <0x0000000082007c28> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
        at java.util.concurrent.locks.LockSupport.parkNanos(java.base@11.0.3/LockSupport.java:234)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@11.0.3/AbstractQueuedSynchronizer.java:2123)
        at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@11.0.3/ScheduledThreadPoolExecutor.java:1182)
        at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@11.0.3/ScheduledThreadPoolExecutor.java:899)
        at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@11.0.3/ThreadPoolExecutor.java:1054)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@11.0.3/ThreadPoolExecutor.java:1114)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@11.0.3/ThreadPoolExecutor.java:628)
        at java.lang.Thread.run(java.base@11.0.3/Thread.java:834)

"Framework Event Dispatcher: Equinox Container: 8d9edbdc-ed67-46a6-9112-292e1c50c8c1" #27 daemon prio=5 os_prio=0 cpu=1.37ms elapsed=1638.24s tid=0x00007f35d8772800 nid=0x156e in Object.wait()  [0x00007f354cda0000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <0x0000000082001e38> (a org.eclipse.osgi.framework.eventmgr.EventManager$EventThread)
        at java.lang.Object.wait(java.base@11.0.3/Object.java:328)
        at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
        - waiting to re-lock in wait() <0x0000000082001e38> (a org.eclipse.osgi.framework.eventmgr.EventManager$EventThread)
        at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:341)

"Start Level: Equinox Container: 8d9edbdc-ed67-46a6-9112-292e1c50c8c1" #28 daemon prio=5 os_prio=0 cpu=1373.26ms elapsed=1638.24s tid=0x00007f35d8790800 nid=0x1571 in Object.wait()  [0x00007f354cb9e000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <0x00000000820032a8> (a org.eclipse.osgi.framework.eventmgr.EventManager$EventThread)
        at java.lang.Object.wait(java.base@11.0.3/Object.java:328)
        at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.getNextEvent(EventManager.java:400)
        - waiting to re-lock in wait() <0x00000000820032a8> (a org.eclipse.osgi.framework.eventmgr.EventManager$EventThread)
        at org.eclipse.osgi.framework.eventmgr.EventManager$EventThread.run(EventManager.java:341)

"SCR Component Actor" #29 daemon prio=5 os_prio=0 cpu=0.21ms elapsed=1638.21s tid=0x00007f350802f800 nid=0x1572 in Object.wait()  [0x00007f354c88c000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <0x0000000082005250> (a java.util.LinkedList)
        at java.lang.Object.wait(java.base@11.0.3/Object.java:328)
        at org.apache.felix.scr.impl.ComponentActorThread.run(ComponentActorThread.java:83)
        - waiting to re-lock in wait() <0x0000000082005250> (a java.util.LinkedList)
        at java.lang.Thread.run(java.base@11.0.3/Thread.java:834)

"Worker-JM" #31 prio=5 os_prio=0 cpu=1.96ms elapsed=1637.84s tid=0x00007f35081d5000 nid=0x1576 in Object.wait()  [0x00007f354c189000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <no object reference available>
        at org.eclipse.core.internal.jobs.InternalWorker.run(InternalWorker.java:61)
        - waiting to re-lock in wait() <0x0000000082007290> (a java.util.ArrayList)

"Worker-2" #34 prio=5 os_prio=0 cpu=1801.51ms elapsed=1637.30s tid=0x00007f34ec001000 nid=0x157c in Object.wait()  [0x00007f354cfa2000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <no object reference available>
        at org.eclipse.core.internal.jobs.WorkerPool.sleep(WorkerPool.java:200)
        - waiting to re-lock in wait() <0x0000000082001348> (a org.eclipse.core.internal.jobs.WorkerPool)
        at org.eclipse.core.internal.jobs.WorkerPool.startJob(WorkerPool.java:242)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:58)

"Java indexing" #35 daemon prio=4 os_prio=0 cpu=573.83ms elapsed=1636.12s tid=0x00007f35084ee000 nid=0x15aa in Object.wait()  [0x00007f354cc9f000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <no object reference available>
        at java.lang.Object.wait(java.base@11.0.3/Object.java:328)
        at org.eclipse.jdt.internal.core.search.processing.JobManager.run(JobManager.java:391)
        - waiting to re-lock in wait() <0x0000000082002038> (a org.eclipse.jdt.internal.core.search.indexing.IndexManager)
        at java.lang.Thread.run(java.base@11.0.3/Thread.java:834)

"logback configurator timer" #37 daemon prio=5 os_prio=0 cpu=0.14ms elapsed=1635.71s tid=0x00007f350880d800 nid=0x15b0 in Object.wait()  [0x00007f34fd6c6000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <0x0000000082964a68> (a java.util.TaskQueue)
        at java.lang.Object.wait(java.base@11.0.3/Object.java:328)
        at java.util.TimerThread.mainLoop(java.base@11.0.3/Timer.java:527)
        - waiting to re-lock in wait() <0x0000000082964a68> (a java.util.TaskQueue)
        at java.util.TimerThread.run(java.base@11.0.3/Timer.java:506)

"pool-3-thread-1" #38 prio=5 os_prio=0 cpu=88.02ms elapsed=1635.61s tid=0x00007f35d87a7000 nid=0x15b3 waiting on condition  [0x00007f34fd3c5000]
   java.lang.Thread.State: TIMED_WAITING (parking)
        at jdk.internal.misc.Unsafe.park(java.base@11.0.3/Native Method)
        - parking to wait for  <0x000000008295a688> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
        at java.util.concurrent.locks.LockSupport.parkNanos(java.base@11.0.3/LockSupport.java:234)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(java.base@11.0.3/AbstractQueuedSynchronizer.java:2123)
        at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@11.0.3/ScheduledThreadPoolExecutor.java:1182)
        at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(java.base@11.0.3/ScheduledThreadPoolExecutor.java:899)
        at java.util.concurrent.ThreadPoolExecutor.getTask(java.base@11.0.3/ThreadPoolExecutor.java:1054)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@11.0.3/ThreadPoolExecutor.java:1114)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@11.0.3/ThreadPoolExecutor.java:628)
        at java.lang.Thread.run(java.base@11.0.3/Thread.java:834)

"pool-2-thread-1" #39 prio=5 os_prio=0 cpu=412.17ms elapsed=1635.44s tid=0x00007f35d884f000 nid=0x15b6 waiting on condition  [0x00007f34fd2c3000]
   java.lang.Thread.State: WAITING (parking)
        at jdk.internal.misc.Unsafe.park(java.base@11.0.3/Native Method)
        - parking to wait for  <0x00000000b58b36d8> (a java.util.concurrent.CompletableFuture$Signaller)
        at java.util.concurrent.locks.LockSupport.park(java.base@11.0.3/LockSupport.java:194)
        at java.util.concurrent.CompletableFuture$Signaller.block(java.base@11.0.3/CompletableFuture.java:1796)
        at java.util.concurrent.ForkJoinPool.managedBlock(java.base@11.0.3/ForkJoinPool.java:3128)
        at java.util.concurrent.CompletableFuture.waitingGet(java.base@11.0.3/CompletableFuture.java:1823)
        at java.util.concurrent.CompletableFuture.join(java.base@11.0.3/CompletableFuture.java:2043)
        at org.eclipse.jdt.ls.core.internal.handlers.JDTLanguageServer.completion(JDTLanguageServer.java:516)
        at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@11.0.3/Native Method)
        at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@11.0.3/NativeMethodAccessorImpl.java:62)
        at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@11.0.3/DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(java.base@11.0.3/Method.java:566)
        at org.eclipse.lsp4j.jsonrpc.services.GenericEndpoint.lambda$null$0(GenericEndpoint.java:65)
        at org.eclipse.lsp4j.jsonrpc.services.GenericEndpoint$$Lambda$132/0x000000084032bc40.apply(Unknown Source)
        at org.eclipse.lsp4j.jsonrpc.services.GenericEndpoint.request(GenericEndpoint.java:120)
        at org.eclipse.lsp4j.jsonrpc.RemoteEndpoint.handleRequest(RemoteEndpoint.java:261)
        at org.eclipse.lsp4j.jsonrpc.RemoteEndpoint.consume(RemoteEndpoint.java:190)
        at org.eclipse.jdt.ls.core.internal.ParentProcessWatcher.lambda$0(ParentProcessWatcher.java:123)
        at org.eclipse.jdt.ls.core.internal.ParentProcessWatcher$$Lambda$130/0x000000084032cc40.consume(Unknown Source)
        at org.eclipse.lsp4j.jsonrpc.json.StreamMessageProducer.handleMessage(StreamMessageProducer.java:194)
        at org.eclipse.lsp4j.jsonrpc.json.StreamMessageProducer.listen(StreamMessageProducer.java:94)
        at org.eclipse.lsp4j.jsonrpc.json.ConcurrentMessageProcessor.run(ConcurrentMessageProcessor.java:113)
        at java.util.concurrent.Executors$RunnableAdapter.call(java.base@11.0.3/Executors.java:515)
        at java.util.concurrent.FutureTask.run(java.base@11.0.3/FutureTask.java:264)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@11.0.3/ThreadPoolExecutor.java:1128)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@11.0.3/ThreadPoolExecutor.java:628)
        at java.lang.Thread.run(java.base@11.0.3/Thread.java:834)

"Worker-5" #42 prio=5 os_prio=0 cpu=1085.39ms elapsed=1634.11s tid=0x00007f34f4031800 nid=0x160a in Object.wait()  [0x00007f34fc355000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
        at java.lang.Object.wait(java.base@11.0.3/Native Method)
        - waiting on <no object reference available>
        at org.eclipse.core.internal.jobs.WorkerPool.sleep(WorkerPool.java:200)
        - waiting to re-lock in wait() <0x0000000082001348> (a org.eclipse.core.internal.jobs.WorkerPool)
        at org.eclipse.core.internal.jobs.WorkerPool.startJob(WorkerPool.java:242)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:58)

"ForkJoinPool.commonPool-worker-51" #43 daemon prio=5 os_prio=0 cpu=22854.30ms elapsed=1631.54s tid=0x00007f3474063800 nid=0x161d runnable  [0x00007f34fc9bd000]
   java.lang.Thread.State: RUNNABLE
        at org.eclipse.jdt.internal.compiler.parser.Scanner.<init>(Scanner.java:214)
        at org.eclipse.jdt.internal.compiler.parser.Scanner.<init>(Scanner.java:326)
        at org.eclipse.jdt.internal.codeassist.complete.CompletionScanner.<init>(CompletionScanner.java:61)
        at org.eclipse.jdt.internal.codeassist.complete.CompletionScanner.<init>(CompletionScanner.java:50)
        at org.eclipse.jdt.internal.codeassist.complete.CompletionJavadocParser.<init>(CompletionJavadocParser.java:62)
        at org.eclipse.jdt.internal.codeassist.complete.CompletionParser.createJavadocParser(CompletionParser.java:5888)
        at org.eclipse.jdt.internal.compiler.parser.Parser.<init>(Parser.java:1014)
        at org.eclipse.jdt.internal.codeassist.impl.AssistParser.<init>(AssistParser.java:135)
        at org.eclipse.jdt.internal.codeassist.complete.CompletionParser.<init>(CompletionParser.java:275)
        at org.eclipse.jdt.internal.codeassist.complete.CompletionParser.createSnapShotParser(CompletionParser.java:5692)
        at org.eclipse.jdt.internal.codeassist.complete.CompletionParser.updateRecoveryState(CompletionParser.java:5849)
        at org.eclipse.jdt.internal.compiler.parser.Parser.resumeOnSyntaxError(Parser.java:14219)
        at org.eclipse.jdt.internal.codeassist.complete.CompletionParser.resumeOnSyntaxError(CompletionParser.java:5733)
        at org.eclipse.jdt.internal.compiler.parser.Parser.parse(Parser.java:12758)
        at org.eclipse.jdt.internal.compiler.parser.Parser.parse(Parser.java:13104)
        at org.eclipse.jdt.internal.compiler.parser.Parser.parse(Parser.java:13061)
        at org.eclipse.jdt.internal.compiler.parser.Parser.dietParse(Parser.java:11448)
        at org.eclipse.jdt.internal.codeassist.complete.CompletionParser.dietParse(CompletionParser.java:5226)
        at org.eclipse.jdt.internal.codeassist.CompletionEngine.complete(CompletionEngine.java:2078)
        at org.eclipse.jdt.internal.core.Openable.codeComplete(Openable.java:136)
        at org.eclipse.jdt.internal.core.CompilationUnit.codeComplete(CompilationUnit.java:366)
        at org.eclipse.jdt.internal.core.CompilationUnit.codeComplete(CompilationUnit.java:356)
        at org.eclipse.jdt.ls.core.internal.handlers.CompletionHandler.computeContentAssist(CompletionHandler.java:150)
        at org.eclipse.jdt.ls.core.internal.handlers.CompletionHandler.completion(CompletionHandler.java:79)
        at org.eclipse.jdt.ls.core.internal.handlers.JDTLanguageServer.lambda$4(JDTLanguageServer.java:514)
        at org.eclipse.jdt.ls.core.internal.handlers.JDTLanguageServer$$Lambda$322/0x000000084063b440.apply(Unknown Source)
        at org.eclipse.jdt.ls.core.internal.BaseJDTLanguageServer.lambda$0(BaseJDTLanguageServer.java:75)
        at org.eclipse.jdt.ls.core.internal.BaseJDTLanguageServer$$Lambda$213/0x0000000840574c40.apply(Unknown Source)
        at java.util.concurrent.CompletableFuture$UniApply.tryFire(java.base@11.0.3/CompletableFuture.java:642)
        at java.util.concurrent.CompletableFuture$Completion.exec(java.base@11.0.3/CompletableFuture.java:479)
        at java.util.concurrent.ForkJoinTask.doExec(java.base@11.0.3/ForkJoinTask.java:290)
        at java.util.concurrent.ForkJoinPool$WorkQueue.topLevelExec(java.base@11.0.3/ForkJoinPool.java:1020)
        at java.util.concurrent.ForkJoinPool.scan(java.base@11.0.3/ForkJoinPool.java:1656)
        at java.util.concurrent.ForkJoinPool.runWorker(java.base@11.0.3/ForkJoinPool.java:1594)
        at java.util.concurrent.ForkJoinWorkerThread.run(java.base@11.0.3/ForkJoinWorkerThread.java:177)

"C2 CompilerThread1" #6 daemon prio=9 os_prio=0 cpu=218.28ms elapsed=0.94s tid=0x00007f35411d2800 nid=0x6f4f waiting on condition  [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"C1 CompilerThread1" #16 daemon prio=9 os_prio=0 cpu=20.57ms elapsed=0.93s tid=0x00007f35443fa800 nid=0x6f66 waiting on condition  [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"C2 CompilerThread2" #7 daemon prio=9 os_prio=0 cpu=82.46ms elapsed=0.89s tid=0x00007f3478346000 nid=0x6f67 waiting on condition  [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE
   No compile task

"Attach Listener" #96 daemon prio=9 os_prio=0 cpu=0.31ms elapsed=0.20s tid=0x00007f3548001000 nid=0x6fd8 waiting on condition  [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"VM Thread" os_prio=0 cpu=235.36ms elapsed=1639.04s tid=0x00007f35d84b9000 nid=0x1554 runnable

"GC Thread#0" os_prio=0 cpu=135.62ms elapsed=1639.06s tid=0x00007f35d802a000 nid=0x154f runnable

"GC Thread#1" os_prio=0 cpu=123.71ms elapsed=1636.36s tid=0x00007f3560001000 nid=0x1586 runnable

"GC Thread#2" os_prio=0 cpu=125.13ms elapsed=1636.36s tid=0x00007f3560002000 nid=0x1587 runnable

"GC Thread#3" os_prio=0 cpu=125.65ms elapsed=1636.36s tid=0x00007f3560003000 nid=0x1588 runnable

"GC Thread#4" os_prio=0 cpu=146.16ms elapsed=1636.36s tid=0x00007f3560004000 nid=0x1589 runnable

"GC Thread#5" os_prio=0 cpu=116.24ms elapsed=1636.36s tid=0x00007f3560006000 nid=0x158a runnable

"GC Thread#6" os_prio=0 cpu=125.53ms elapsed=1636.36s tid=0x00007f3560007800 nid=0x158b runnable

"GC Thread#7" os_prio=0 cpu=132.49ms elapsed=1636.36s tid=0x00007f3560009000 nid=0x158c runnable

"GC Thread#8" os_prio=0 cpu=135.46ms elapsed=1636.36s tid=0x00007f356000a800 nid=0x158d runnable

"GC Thread#9" os_prio=0 cpu=130.16ms elapsed=1636.36s tid=0x00007f356000c800 nid=0x158e runnable

"GC Thread#10" os_prio=0 cpu=131.32ms elapsed=1636.36s tid=0x00007f356000e000 nid=0x158f runnable

"GC Thread#11" os_prio=0 cpu=120.38ms elapsed=1636.36s tid=0x00007f356000f800 nid=0x1590 runnable

"GC Thread#12" os_prio=0 cpu=124.01ms elapsed=1636.36s tid=0x00007f3560011000 nid=0x1591 runnable

"GC Thread#13" os_prio=0 cpu=122.90ms elapsed=1636.36s tid=0x00007f3560012800 nid=0x1592 runnable

"GC Thread#14" os_prio=0 cpu=132.99ms elapsed=1636.36s tid=0x00007f3560014800 nid=0x1593 runnable

"GC Thread#15" os_prio=0 cpu=122.29ms elapsed=1636.36s tid=0x00007f3560016000 nid=0x1594 runnable

"GC Thread#16" os_prio=0 cpu=127.85ms elapsed=1636.36s tid=0x00007f3560017800 nid=0x1595 runnable

"GC Thread#17" os_prio=0 cpu=115.13ms elapsed=1636.36s tid=0x00007f3560019800 nid=0x1596 runnable

"GC Thread#18" os_prio=0 cpu=118.17ms elapsed=1636.36s tid=0x00007f356001b000 nid=0x1597 runnable

"GC Thread#19" os_prio=0 cpu=132.95ms elapsed=1636.36s tid=0x00007f356001d000 nid=0x1598 runnable

"GC Thread#20" os_prio=0 cpu=124.05ms elapsed=1636.36s tid=0x00007f356001f000 nid=0x1599 runnable

"GC Thread#21" os_prio=0 cpu=125.84ms elapsed=1636.36s tid=0x00007f3560020800 nid=0x159a runnable

"GC Thread#22" os_prio=0 cpu=119.21ms elapsed=1636.36s tid=0x00007f3560022800 nid=0x159b runnable

"G1 Main Marker" os_prio=0 cpu=1.55ms elapsed=1639.05s tid=0x00007f35d809a000 nid=0x1550 runnable

"G1 Conc#0" os_prio=0 cpu=35.86ms elapsed=1639.05s tid=0x00007f35d809c000 nid=0x1551 runnable

"G1 Conc#1" os_prio=0 cpu=41.37ms elapsed=1636.34s tid=0x00007f3570001000 nid=0x159c runnable

"G1 Conc#2" os_prio=0 cpu=37.29ms elapsed=1636.34s tid=0x00007f3570002800 nid=0x159d runnable

"G1 Conc#3" os_prio=0 cpu=37.97ms elapsed=1636.33s tid=0x00007f3570004000 nid=0x159e runnable

"G1 Conc#4" os_prio=0 cpu=31.90ms elapsed=1636.33s tid=0x00007f3570006000 nid=0x159f runnable

"G1 Conc#5" os_prio=0 cpu=37.72ms elapsed=1636.33s tid=0x00007f3570008000 nid=0x15a0 runnable

"G1 Refine#0" os_prio=0 cpu=24.60ms elapsed=1639.05s tid=0x00007f35d83ff000 nid=0x1552 runnable

"G1 Refine#1" os_prio=0 cpu=5.35ms elapsed=1634.74s tid=0x00007f3564001000 nid=0x15c5 runnable

"G1 Refine#2" os_prio=0 cpu=4.45ms elapsed=1634.74s tid=0x00007f343c001000 nid=0x15c6 runnable

"G1 Refine#3" os_prio=0 cpu=3.95ms elapsed=1634.74s tid=0x00007f3440001000 nid=0x15c7 runnable

"G1 Refine#4" os_prio=0 cpu=3.20ms elapsed=1634.74s tid=0x00007f3434001000 nid=0x15c8 runnable

"G1 Refine#5" os_prio=0 cpu=3.02ms elapsed=1634.74s tid=0x00007f3438001000 nid=0x15c9 runnable

"G1 Refine#6" os_prio=0 cpu=2.92ms elapsed=1634.74s tid=0x00007f342c001000 nid=0x15ca runnable

"G1 Refine#7" os_prio=0 cpu=2.74ms elapsed=1634.74s tid=0x00007f3430001000 nid=0x15cb runnable

"G1 Refine#8" os_prio=0 cpu=2.37ms elapsed=1634.74s tid=0x00007f3424001000 nid=0x15cc runnable

"G1 Refine#9" os_prio=0 cpu=2.36ms elapsed=1634.74s tid=0x00007f3428001000 nid=0x15cd runnable

"G1 Refine#10" os_prio=0 cpu=2.14ms elapsed=1634.74s tid=0x00007f341c001000 nid=0x15ce runnable

"G1 Refine#11" os_prio=0 cpu=1.95ms elapsed=1634.74s tid=0x00007f3420001000 nid=0x15cf runnable

"G1 Refine#12" os_prio=0 cpu=1.92ms elapsed=1634.74s tid=0x00007f3414001000 nid=0x15d0 runnable

"G1 Refine#13" os_prio=0 cpu=1.71ms elapsed=1634.74s tid=0x00007f3418001000 nid=0x15d1 runnable

"G1 Refine#14" os_prio=0 cpu=1.21ms elapsed=1634.74s tid=0x00007f340c001000 nid=0x15d2 runnable

"G1 Refine#15" os_prio=0 cpu=1.21ms elapsed=1634.74s tid=0x00007f3410001000 nid=0x15d3 runnable

"G1 Refine#16" os_prio=0 cpu=0.63ms elapsed=1634.74s tid=0x00007f3404001000 nid=0x15d4 runnable

"G1 Refine#17" os_prio=0 cpu=0.06ms elapsed=1634.74s tid=0x00007f3408001000 nid=0x15d5 runnable

"G1 Young RemSet Sampling" os_prio=0 cpu=326.50ms elapsed=1639.05s tid=0x00007f35d8401000 nid=0x1553 runnable
"VM Periodic Task Thread" os_prio=0 cpu=446.77ms elapsed=1639.00s tid=0x00007f35d850b000 nid=0x155e waiting on condition

JNI global refs: 23, weak refs: 0

jdt.ls version: 0.67.0 OS: Linux (also tried on macOS)

puremourning commented 3 years ago

Full trace from the client (look for RX and TX)

2021-01-08 18:11:35,576 - DEBUG - No global extra conf, not calling method YcmCorePreload
2021-01-08 18:11:35,604 - INFO - Completion config: 50, detailing 10 candiates
2021-01-08 18:11:35,604 - INFO - Completion config: 50, detailing 10 candiates
2021-01-08 18:11:35,604 - INFO - Completion config: 50, detailing 10 candiates
2021-01-08 18:11:35,605 - INFO - Completion config: 50, detailing 10 candiates
2021-01-08 18:11:35,622 - INFO - Received ready request
2021-01-08 18:11:35,624 - INFO - Received signature help available request
2021-01-08 18:11:35,626 - INFO - Looking for jdt.ls
2021-01-08 18:11:35,627 - DEBUG - Found launchers: ['/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/third_party/eclipse.jdt.ls/target/repository/plugins/org.eclipse.equinox.launcher_1.5.800.v20200727-1323.jar']
2021-01-08 18:11:35,627 - INFO - Completion config: 50, detailing 10 candiates
2021-01-08 18:11:35,627 - DEBUG - Found launchers: ['/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/third_party/eclipse.jdt.ls/target/repository/plugins/org.eclipse.equinox.launcher_1.5.800.v20200727-1323.jar']
2021-01-08 18:11:35,628 - DEBUG - /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/.gadgets.d is not an extension directory
2021-01-08 18:11:35,628 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/local-lua-debugger-vscode/package.json is not a java extension
2021-01-08 18:11:35,629 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/CodeLLDB/package.json is not a java extension
2021-01-08 18:11:35,629 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/java-language-server/package.json is not a java extension
2021-01-08 18:11:35,629 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-go/package.json is not a java extension
2021-01-08 18:11:35,629 - DEBUG - /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/.gadgets.json is not an extension directory
2021-01-08 18:11:35,629 - DEBUG - /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/debugpy is not an extension directory
2021-01-08 18:11:35,629 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-php-debug/package.json is not a java extension
2021-01-08 18:11:35,630 - DEBUG - /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/.gadgets.manifest.json is not an extension directory
2021-01-08 18:11:35,630 - DEBUG - /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/netcoredbg is not an extension directory
2021-01-08 18:11:35,630 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-cpptools/package.json is not a java extension
2021-01-08 18:11:35,630 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-mono-debug/package.json is not a java extension
2021-01-08 18:11:35,631 - INFO - Found bundle: /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-java-debug/package.json
2021-01-08 18:11:35,631 - DEBUG - /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/download is not an extension directory
2021-01-08 18:11:35,631 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-node-debug2/package.json is not a java extension
2021-01-08 18:11:35,631 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-bash-debug/package.json is not a java extension
2021-01-08 18:11:35,631 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/debugger-for-chrome/package.json is not a java extension
2021-01-08 18:11:35,631 - DEBUG - /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/tclpro is not an extension directory
2021-01-08 18:11:35,632 - INFO - Bundle /Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-python/package.json is not a java extension
2021-01-08 18:11:35,632 - INFO - extension directory does not exist: /Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/third_party/eclipse.jdt.ls/extensions
2021-01-08 18:11:35,632 - DEBUG - Found launchers: ['/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/third_party/eclipse.jdt.ls/target/repository/plugins/org.eclipse.equinox.launcher_1.5.800.v20200727-1323.jar']
2021-01-08 18:11:35,663 - INFO - Received event notification
2021-01-08 18:11:35,663 - DEBUG - Event name: BufferVisit
2021-01-08 18:11:35,664 - INFO - Received event notification
2021-01-08 18:11:35,664 - DEBUG - Event name: FileReadyToParse
2021-01-08 18:11:35,664 - INFO - Adding buffer identifiers for file: /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java
2021-01-08 18:11:35,667 - DEBUG - Using path /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd for extra_conf_dir
2021-01-08 18:11:35,667 - INFO - Starting jdt.ls Language Server...
2021-01-08 18:11:35,667 - DEBUG - Found .project style project in /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project. Searching for project root:
2021-01-08 18:11:35,667 - DEBUG -   Project root is /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project
2021-01-08 18:11:35,668 - INFO - Starting jdt.ls: ['/usr/local/opt/java/bin/java', '-Dfile.encoding=UTF-8', '-Declipse.application=org.eclipse.jdt.ls.core.id1', '-Dosgi.bundles.defaultStartLevel=4', '-Declipse.product=org.eclipse.jdt.ls.core.product', '-Dlog.level=ALL', '-jar', '/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/third_party/eclipse.jdt.ls/target/repository/plugins/org.eclipse.equinox.launcher_1.5.800.v20200727-1323.jar', '-configuration', '/Users/ben/.ycmd/java/Workspace/config_mac', '-data', '/Users/ben/.ycmd/java/Workspace/38e066cf6082f8705d1a92faca30d8d86fa9095b931ec7c38404715489315c53']
2021-01-08 18:11:35,670 - INFO - jdt.ls started with PID 13253
2021-01-08 18:11:35,671 - DEBUG - TX: Sending message: b'Content-Length: 1522\r\n\r\n{"id":1,"jsonrpc":"2.0","method":"initialize","params":{"capabilities":{"textDocument":{"codeAction":{"codeActionLiteralSupport":{"codeActionKind":{"valueSet":["","quickfix","refactor","refactor.extract","refactor.inline","refactor.rewrite","source","source.organizeImports"]}}},"completion":{"completionItem":{"documentationFormat":["plaintext","markdown"]},"completionItemKind":{"valueSet":[1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25]}},"documentSymbol":{"hierarchicalDocumentSymbolSupport":false,"labelSupport":false,"symbolKind":{"valueSet":[1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26]}},"hover":{"contentFormat":["plaintext","markdown"]},"signatureHelp":{"signatureInformation":{"documentationFormat":["plaintext","markdown"],"parameterInformation":{"labelOffsetSupport":true}}},"synchronization":{"didSave":true}},"workspace":{"applyEdit":true,"didChangeWatchedFiles":{"dynamicRegistration":true},"symbol":{"symbolKind":{"valueSet":[1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26]}},"workspaceEdit":{"documentChanges":true}}},"initializationOptions":{"bundles":["/Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-java-debug/./server/com.microsoft.java.debug.plugin-0.26.0.jar"]},"processId":13252,"rootPath":"/Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project","rootUri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project"}}'
2021-01-08 18:11:35,673 - INFO - Received filetype completion available request
2021-01-08 18:11:36,577 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:36 Main thread is waiting"}}'
2021-01-08 18:11:36,586 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:36 \\u003e\\u003e initialize"}}'
2021-01-08 18:11:36,613 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:36 Initializing Java Language Server 0.63.0.202010141717"}}'
2021-01-08 18:11:36,629 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:36 Static Commands: []"}}'
2021-01-08 18:11:36,629 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:36 Non-Static Commands: [java.edit.organizeImports, java.project.refreshDiagnostics, java.project.import, java.project.removeFromSourcePath, java.project.listSourcePaths, java.project.provideSemanticTokens, java.project.getAll, java.project.isTestFile, java.project.getClasspaths, java.project.getSemanticTokensLegend, java.project.getSettings, java.project.updateSourceAttachment, java.project.resolveSourceAttachment, java.project.addToSourcePath]"}}'
2021-01-08 18:11:36,630 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:36 Static Commands: []"}}'
2021-01-08 18:11:36,630 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:36 Non-Static Commands: [vscode.java.checkProjectSettings, vscode.java.isOnClasspath, vscode.java.fetchUsageData, vscode.java.validateLaunchConfig, vscode.java.resolveMainMethod, vscode.java.resolveClasspath, vscode.java.resolveBuildFiles, vscode.java.resolveMainClass, vscode.java.updateDebugSettings, vscode.java.fetchPlatformSettings, vscode.java.buildWorkspace, vscode.java.startDebugSession, vscode.java.inferLaunchCommandLength, vscode.java.resolveElementAtSelection, vscode.java.resolveJavaExecutable]"}}'
2021-01-08 18:11:36,634 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"Init..."}}'
2021-01-08 18:11:36,635 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","id":1,"result":{"capabilities":{"textDocumentSync":{"openClose":true,"change":2,"save":{"includeText":true}},"hoverProvider":true,"completionProvider":{"resolveProvider":true,"triggerCharacters":[".","@","#","*"]},"signatureHelpProvider":{"triggerCharacters":["(",","]},"definitionProvider":true,"typeDefinitionProvider":true,"implementationProvider":true,"referencesProvider":true,"documentHighlightProvider":true,"documentSymbolProvider":true,"workspaceSymbolProvider":true,"codeActionProvider":true,"codeLensProvider":{"resolveProvider":true},"documentFormattingProvider":true,"documentRangeFormattingProvider":true,"documentOnTypeFormattingProvider":{"firstTriggerCharacter":";","moreTriggerCharacter":["\\n","}"]},"renameProvider":{"prepareProvider":true},"foldingRangeProvider":true,"executeCommandProvider":{"commands":["vscode.java.checkProjectSettings","vscode.java.isOnClasspath","java.project.import","vscode.java.fetchUsageData","vscode.java.validateLaunchConfig","vscode.java.resolveMainMethod","java.project.getSettings","vscode.java.resolveMainClass","vscode.java.buildWorkspace","vscode.java.resolveElementAtSelection","vscode.java.resolveJavaExecutable","java.edit.organizeImports","java.project.refreshDiagnostics","java.project.removeFromSourcePath","java.project.listSourcePaths","java.project.provideSemanticTokens","java.project.getAll","java.project.isTestFile","java.project.getClasspaths","java.project.getSemanticTokensLegend","java.project.updateSourceAttachment","vscode.java.resolveClasspath","vscode.java.resolveBuildFiles","vscode.java.updateDebugSettings","vscode.java.fetchPlatformSettings","java.project.resolveSourceAttachment","java.project.addToSourcePath","vscode.java.startDebugSession","vscode.java.inferLaunchCommandLength"]},"workspace":{"workspaceFolders":{"supported":true,"changeNotifications":true}},"callHierarchyProvider":true,"selectionRangeProvider":true}}}'
2021-01-08 18:11:36,635 - INFO - None: Language server requires resolve request
2021-01-08 18:11:36,635 - INFO - None: Language server requires sync type of Incremental
2021-01-08 18:11:36,635 - DEBUG - java: Server declares trigger characters: ['.', '@', '#', '*']
2021-01-08 18:11:36,635 - INFO - java: Using trigger characters for semantic triggers: .,@,#,*
2021-01-08 18:11:36,636 - DEBUG - java: Server declares signature trigger characters: ['(', ',']
2021-01-08 18:11:36,636 - INFO - java: Using characters for signature triggers: (,,,,
2021-01-08 18:11:36,636 - DEBUG - TX: Sending notification: b'Content-Length: 52\r\n\r\n{"jsonrpc":"2.0","method":"initialized","params":{}}'
2021-01-08 18:11:36,636 - DEBUG - TX: Sending notification: b'Content-Length: 223\r\n\r\n{"jsonrpc":"2.0","method":"workspace/didChangeConfiguration","params":{"settings":{"bundles":["/Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-java-debug/./server/com.microsoft.java.debug.plugin-0.26.0.jar"]}}}'
2021-01-08 18:11:36,636 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Open
2021-01-08 18:11:36,636 - DEBUG - TX: Sending notification: b'Content-Length: 1009\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didOpen","params":{"textDocument":{"languageId":"java","text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n","uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":1}}}'
2021-01-08 18:11:36,636 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"0% Starting Java Language Server"}}'
2021-01-08 18:11:36,637 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:36 \\u003e\\u003e initialized"}}'
2021-01-08 18:11:36,638 - INFO - Server reported: 8 Jan 2021, 18:11:36 Main thread is waiting
2021-01-08 18:11:36,638 - INFO - Server reported: 8 Jan 2021, 18:11:36 >> initialize
2021-01-08 18:11:36,638 - INFO - Server reported: 8 Jan 2021, 18:11:36 Initializing Java Language Server 0.63.0.202010141717
2021-01-08 18:11:36,638 - INFO - Server reported: 8 Jan 2021, 18:11:36 Static Commands: []
2021-01-08 18:11:36,639 - INFO - Server reported: 8 Jan 2021, 18:11:36 Non-Static Commands: [java.edit.organizeImports, java.project.refreshDiagnostics, java.project.import, java.project.removeFromSourcePath, java.project.listSourcePaths, java.project.provideSemanticTokens, java.project.getAll, java.project.isTestFile, java.project.getClasspaths, java.project.getSemanticTokensLegend, java.project.getSettings, java.project.updateSourceAttachment, java.project.resolveSourceAttachment, java.project.addToSourcePath]
2021-01-08 18:11:36,639 - INFO - Server reported: 8 Jan 2021, 18:11:36 Static Commands: []
2021-01-08 18:11:36,639 - INFO - Server reported: 8 Jan 2021, 18:11:36 Non-Static Commands: [vscode.java.checkProjectSettings, vscode.java.isOnClasspath, vscode.java.fetchUsageData, vscode.java.validateLaunchConfig, vscode.java.resolveMainMethod, vscode.java.resolveClasspath, vscode.java.resolveBuildFiles, vscode.java.resolveMainClass, vscode.java.updateDebugSettings, vscode.java.fetchPlatformSettings, vscode.java.buildWorkspace, vscode.java.startDebugSession, vscode.java.inferLaunchCommandLength, vscode.java.resolveElementAtSelection, vscode.java.resolveJavaExecutable]
2021-01-08 18:11:36,639 - INFO - Server reported: 8 Jan 2021, 18:11:36 >> initialized
2021-01-08 18:11:36,929 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"30% Starting Java Language Server"}}'
2021-01-08 18:11:36,947 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"100% Starting Java Language Server - /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/wobble"}}'
2021-01-08 18:11:36,947 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"1000% Starting Java Language Server - /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/wobble"}}'
2021-01-08 18:11:36,947 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"1005% Starting Java Language Server - /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/wobble"}}'
2021-01-08 18:11:36,953 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"1010% Starting Java Language Server - /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/wobble"}}'
2021-01-08 18:11:36,953 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"1100% Starting Java Language Server - /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/wobble"}}'
2021-01-08 18:11:36,953 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"1100% Starting Java Language Server - /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/wobble"}}'
2021-01-08 18:11:36,954 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:36 Workspace initialized in 322ms"}}'
2021-01-08 18:11:36,954 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Started","message":"Ready"}}'
2021-01-08 18:11:36,954 - INFO - jdt.ls initialized successfully
2021-01-08 18:11:36,958 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"Starting","message":"1100% Starting Java Language Server - /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/wobble"}}'
2021-01-08 18:11:37,051 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 \\u003e\\u003e initialization job finished"}}'
2021-01-08 18:11:37,052 - INFO - Server reported: 8 Jan 2021, 18:11:36 Workspace initialized in 322ms
2021-01-08 18:11:37,052 - INFO - Server reported: 8 Jan 2021, 18:11:37 >> initialization job finished
2021-01-08 18:11:37,052 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 \\u003e\\u003e workspace/didChangeConfiguration"}}'
2021-01-08 18:11:37,066 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 \\u003e\\u003e New configuration: {bundles\\u003d[/Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-java-debug/./server/com.microsoft.java.debug.plugin-0.26.0.jar]}"}}'
2021-01-08 18:11:37,067 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 \\u003e\\u003e document/didOpen"}}'
2021-01-08 18:11:37,158 - INFO - Server reported: 8 Jan 2021, 18:11:37 >> workspace/didChangeConfiguration
2021-01-08 18:11:37,158 - INFO - Server reported: 8 Jan 2021, 18:11:37 >> New configuration: {bundles=[/Users/ben/.vim/bundle/vimspector-Clean/gadgets/macos/vscode-java-debug/./server/com.microsoft.java.debug.plugin-0.26.0.jar]}
2021-01-08 18:11:37,158 - INFO - Server reported: 8 Jan 2021, 18:11:37 >> document/didOpen
2021-01-08 18:11:37,222 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 Reconciled 0. Took 0 ms"}}'
2021-01-08 18:11:37,222 - INFO - Server reported: 8 Jan 2021, 18:11:37 Reconciled 0. Took 0 ms
2021-01-08 18:11:37,440 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 begin problem for /TestEnum.java"}}'
2021-01-08 18:11:37,440 - INFO - Server reported: 8 Jan 2021, 18:11:37 begin problem for /TestEnum.java
2021-01-08 18:11:37,440 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 0 problems reported for /TestEnum.java"}}'
2021-01-08 18:11:37,440 - INFO - Server reported: 8 Jan 2021, 18:11:37 0 problems reported for /TestEnum.java
2021-01-08 18:11:37,442 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"textDocument/publishDiagnostics","params":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","diagnostics":[]}}'
2021-01-08 18:11:37,443 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 Validated 1. Took 209 ms"}}'
2021-01-08 18:11:37,463 - INFO - Server reported: 8 Jan 2021, 18:11:37 Validated 1. Took 209 ms
2021-01-08 18:11:37,467 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 \\u003e\\u003e build jobs finished"}}'
2021-01-08 18:11:37,468 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"language/status","params":{"type":"ServiceReady","message":"ServiceReady"}}'
2021-01-08 18:11:37,468 - INFO - Server reported: 8 Jan 2021, 18:11:37 >> build jobs finished
2021-01-08 18:11:37,480 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"textDocument/publishDiagnostics","params":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/Test.java","diagnostics":[{"range":{"start":{"line":12,"character":9},"end":{"line":12,"character":21}},"severity":1,"code":"67108979","source":"Java","message":"The method doUnic\xc3\xb8deTes() in the type Test is not applicable for the arguments (String)"}]}}'
2021-01-08 18:11:37,489 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"textDocument/publishDiagnostics","params":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/TestWidgetImpl.java","diagnostics":[{"range":{"start":{"line":14,"character":8},"end":{"line":14,"character":9}},"severity":2,"code":"536870973","source":"Java","message":"The value of the local variable a is not used"},{"range":{"start":{"line":33,"character":11},"end":{"line":33,"character":14}},"severity":1,"code":"1610612976","source":"Java","message":"Syntax error, insert \\";\\" to complete BlockStatements"},{"range":{"start":{"line":33,"character":11},"end":{"line":33,"character":14}},"severity":1,"code":"33554515","source":"Java","message":"ISR cannot be resolved to a variable"}]}}'
2021-01-08 18:11:37,494 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"textDocument/publishDiagnostics","params":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/TestLauncher.java","diagnostics":[{"range":{"start":{"line":27,"character":15},"end":{"line":27,"character":27}},"severity":1,"code":"67109264","source":"Java","message":"The type new TestLauncher.Launchable(){} must implement the inherited abstract method TestLauncher.Launchable.launch(TestFactory)"},{"range":{"start":{"line":29,"character":18},"end":{"line":29,"character":26}},"severity":1,"code":"67109498","source":"Java","message":"The method launch() of type new TestLauncher.Launchable(){} must override or implement a supertype method"},{"range":{"start":{"line":30,"character":31},"end":{"line":30,"character":38}},"severity":1,"code":"33554506","source":"Java","message":"Cannot make a static reference to the non-static field factory"}]}}'
2021-01-08 18:11:37,498 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"textDocument/publishDiagnostics","params":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/test/TestFactory.java","diagnostics":[{"range":{"start":{"line":26,"character":9},"end":{"line":26,"character":15}},"severity":1,"code":"16777233","source":"Java","message":"Type mismatch: cannot convert from int to boolean"},{"range":{"start":{"line":29,"character":9},"end":{"line":29,"character":15}},"severity":1,"code":"16777233","source":"Java","message":"Type mismatch: cannot convert from int to boolean"},{"range":{"start":{"line":29,"character":22},"end":{"line":29,"character":46}},"severity":1,"code":"67108979","source":"Java","message":"The method doSomethingVaguelyUseful() in the type AbstractTestWidget is not applicable for the arguments (TestFactory.Bar)"},{"range":{"start":{"line":14,"character":18},"end":{"line":14,"character":28}},"severity":2,"code":"570425421","source":"Java","message":"The value of the field TestFactory.Bar.testString is not used"},{"range":{"start":{"line":17,"character":23},"end":{"line":17,"character":29}},"severity":1,"code":"16777218","source":"Java","message":"Wibble cannot be resolved to a type"},{"range":{"start":{"line":18,"character":14},"end":{"line":18,"character":20}},"severity":1,"code":"33554515","source":"Java","message":"Wibble cannot be resolved to a variable"}]}}'
2021-01-08 18:11:37,498 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 \\u003e\\u003e registerWatchers\\u0027"}}'
2021-01-08 18:11:37,500 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 \\u003e\\u003e registerFeature \\u0027workspace/didChangeWatchedFiles\\u0027"}}'
2021-01-08 18:11:37,502 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","id":"1","method":"client/registerCapability","params":{"registrations":[{"id":"faf85d8e-c446-41a8-b6b3-67c3224b5d52","method":"workspace/didChangeWatchedFiles","registerOptions":{"watchers":[{"globPattern":"**/*.java"},{"globPattern":"**/.project"},{"globPattern":"**/.classpath"},{"globPattern":"**/.settings/*.prefs"},{"globPattern":"**/src/**"},{"globPattern":"**/*.gradle"},{"globPattern":"**/gradle.properties"},{"globPattern":"**/pom.xml"},{"globPattern":"/Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project","kind":4}]}}]}}'
2021-01-08 18:11:37,504 - DEBUG - TX: Sending response: b'Content-Length: 40\r\n\r\n{"id":"1","jsonrpc":"2.0","result":null}'
2021-01-08 18:11:37,504 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:37 \\u003e\\u003e watchers registered"}}'
2021-01-08 18:11:37,569 - INFO - Server reported: 8 Jan 2021, 18:11:37 >> registerWatchers'
2021-01-08 18:11:37,569 - INFO - Server reported: 8 Jan 2021, 18:11:37 >> registerFeature 'workspace/didChangeWatchedFiles'
2021-01-08 18:11:37,569 - INFO - Server reported: 8 Jan 2021, 18:11:37 >> watchers registered
2021-01-08 18:11:38,679 - INFO - Received event notification
2021-01-08 18:11:38,679 - DEBUG - Event name: CurrentIdentifierFinished
2021-01-08 18:11:40,476 - INFO - Received completion request
2021-01-08 18:11:40,476 - DEBUG - Using filetype completion: False
2021-01-08 18:11:40,477 - INFO - Received signature help available request
2021-01-08 18:11:40,540 - INFO - Received completion request
2021-01-08 18:11:40,540 - DEBUG - Using filetype completion: False
2021-01-08 18:11:40,541 - INFO - Received signature help request
2021-01-08 18:11:40,653 - INFO - Received event notification
2021-01-08 18:11:40,653 - DEBUG - Event name: CurrentIdentifierFinished
2021-01-08 18:11:40,654 - INFO - Adding ONE buffer identifier for file: /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java
2021-01-08 18:11:40,654 - INFO - Received completion request
2021-01-08 18:11:40,654 - DEBUG - Using filetype completion: False
2021-01-08 18:11:40,655 - INFO - Received signature help request
2021-01-08 18:11:40,750 - INFO - Received completion request
2021-01-08 18:11:40,750 - DEBUG - Using filetype completion: False
2021-01-08 18:11:40,751 - INFO - Received signature help request
2021-01-08 18:11:40,751 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:40,751 - DEBUG - TX: Sending notification: b'Content-Length: 1028\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":2}}}'
2021-01-08 18:11:40,751 - DEBUG - TX: Sending message: b'Content-Length: 281\r\n\r\n{"id":2,"jsonrpc":"2.0","method":"textDocument/signatureHelp","params":{"position":{"character":14,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:40,753 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:40 \\u003e\\u003e document/didChange"}}'
2021-01-08 18:11:40,753 - INFO - Server reported: 8 Jan 2021, 18:11:40 >> document/didChange
2021-01-08 18:11:40,758 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:40 \\u003e\\u003e document/signatureHelp"}}'
2021-01-08 18:11:40,758 - INFO - Server reported: 8 Jan 2021, 18:11:40 >> document/signatureHelp
2021-01-08 18:11:40,780 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","id":2,"result":{"signatures":[]}}'
2021-01-08 18:11:40,964 - INFO - Received completion request
2021-01-08 18:11:40,964 - DEBUG - Using filetype completion: False
2021-01-08 18:11:40,965 - INFO - Received signature help request
2021-01-08 18:11:41,020 - INFO - Received completion request
2021-01-08 18:11:41,020 - DEBUG - Using filetype completion: False
2021-01-08 18:11:41,021 - INFO - Received signature help request
2021-01-08 18:11:41,161 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:41 Reconciled 0. Took 3 ms"}}'
2021-01-08 18:11:41,161 - INFO - Server reported: 8 Jan 2021, 18:11:41 Reconciled 0. Took 3 ms
2021-01-08 18:11:41,166 - INFO - Received completion request
2021-01-08 18:11:41,166 - DEBUG - Using filetype completion: False
2021-01-08 18:11:41,167 - INFO - Received signature help request
2021-01-08 18:11:41,503 - INFO - Received event notification
2021-01-08 18:11:41,503 - DEBUG - Event name: CurrentIdentifierFinished
2021-01-08 18:11:41,503 - INFO - Adding ONE buffer identifier for file: /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java
2021-01-08 18:11:41,504 - INFO - Received completion request
2021-01-08 18:11:41,504 - DEBUG - Using filetype completion: True
2021-01-08 18:11:41,504 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:41,504 - DEBUG - TX: Sending notification: b'Content-Length: 1032\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":3}}}'
2021-01-08 18:11:41,504 - INFO - Received signature help request
2021-01-08 18:11:41,505 - DEBUG - TX: Sending message: b'Content-Length: 278\r\n\r\n{"id":3,"jsonrpc":"2.0","method":"textDocument/completion","params":{"position":{"character":18,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:41,505 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:41 \\u003e\\u003e document/didChange"}}'
2021-01-08 18:11:41,505 - INFO - Server reported: 8 Jan 2021, 18:11:41 >> document/didChange
2021-01-08 18:11:41,507 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:41 \\u003e\\u003e document/completion"}}'
2021-01-08 18:11:41,508 - INFO - Server reported: 8 Jan 2021, 18:11:41 >> document/completion
2021-01-08 18:11:41,756 - INFO - Received completion request
2021-01-08 18:11:41,756 - DEBUG - Using filetype completion: True
2021-01-08 18:11:41,756 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:41,756 - DEBUG - TX: Sending notification: b'Content-Length: 1033\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.i\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":4}}}'
2021-01-08 18:11:41,756 - DEBUG - TX: Sending message: b'Content-Length: 278\r\n\r\n{"id":4,"jsonrpc":"2.0","method":"textDocument/completion","params":{"position":{"character":18,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:41,757 - INFO - Received signature help request
2021-01-08 18:11:41,884 - INFO - Received completion request
2021-01-08 18:11:41,884 - DEBUG - Using filetype completion: True
2021-01-08 18:11:41,884 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:41,884 - DEBUG - TX: Sending notification: b'Content-Length: 1034\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.in\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":5}}}'
2021-01-08 18:11:41,884 - DEBUG - TX: Sending message: b'Content-Length: 278\r\n\r\n{"id":5,"jsonrpc":"2.0","method":"textDocument/completion","params":{"position":{"character":18,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:41,885 - INFO - Received signature help request
2021-01-08 18:11:41,915 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:41 Reconciled 0. Took 4 ms"}}'
2021-01-08 18:11:41,915 - INFO - Server reported: 8 Jan 2021, 18:11:41 Reconciled 0. Took 4 ms
2021-01-08 18:11:42,004 - INFO - Received completion request
2021-01-08 18:11:42,004 - DEBUG - Using filetype completion: True
2021-01-08 18:11:42,005 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:42,005 - DEBUG - TX: Sending notification: b'Content-Length: 1035\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.ind\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":6}}}'
2021-01-08 18:11:42,005 - DEBUG - TX: Sending message: b'Content-Length: 278\r\n\r\n{"id":6,"jsonrpc":"2.0","method":"textDocument/completion","params":{"position":{"character":18,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:42,005 - INFO - Received signature help request
2021-01-08 18:11:42,348 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:42 begin problem for /TestEnum.java"}}'
2021-01-08 18:11:42,348 - INFO - Server reported: 8 Jan 2021, 18:11:42 begin problem for /TestEnum.java
2021-01-08 18:11:42,348 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:42 3 problems reported for /TestEnum.java"}}'
2021-01-08 18:11:42,348 - INFO - Server reported: 8 Jan 2021, 18:11:42 3 problems reported for /TestEnum.java
2021-01-08 18:11:42,348 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"textDocument/publishDiagnostics","params":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","diagnostics":[{"range":{"start":{"line":17,"character":10},"end":{"line":17,"character":18}},"severity":1,"code":"1610612972","source":"Java","message":"Syntax error on token(s), misplaced construct(s)"},{"range":{"start":{"line":21,"character":10},"end":{"line":21,"character":11}},"severity":1,"code":"134217858","source":"Java","message":"The constructor TestEnum.ThisIsTheEnum() is undefined"},{"range":{"start":{"line":21,"character":13},"end":{"line":21,"character":15}},"severity":1,"code":"134217858","source":"Java","message":"The constructor TestEnum.ThisIsTheEnum() is undefined"}]}}'
2021-01-08 18:11:42,349 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:42 Validated 1. Took 30 ms"}}'
2021-01-08 18:11:42,374 - INFO - Server reported: 8 Jan 2021, 18:11:42 Validated 1. Took 30 ms
2021-01-08 18:11:42,381 - INFO - Received completion request
2021-01-08 18:11:42,381 - DEBUG - Using filetype completion: True
2021-01-08 18:11:42,381 - INFO - Received signature help request
2021-01-08 18:11:42,382 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:42,382 - DEBUG - TX: Sending notification: b'Content-Length: 1036\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.inde\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":7}}}'
2021-01-08 18:11:42,382 - DEBUG - TX: Sending message: b'Content-Length: 278\r\n\r\n{"id":7,"jsonrpc":"2.0","method":"textDocument/completion","params":{"position":{"character":18,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:42,629 - INFO - Received completion request
2021-01-08 18:11:42,629 - DEBUG - Using filetype completion: True
2021-01-08 18:11:42,629 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:42,629 - DEBUG - TX: Sending notification: b'Content-Length: 1037\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.index\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":8}}}'
2021-01-08 18:11:42,629 - DEBUG - TX: Sending message: b'Content-Length: 278\r\n\r\n{"id":8,"jsonrpc":"2.0","method":"textDocument/completion","params":{"position":{"character":18,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:42,629 - INFO - Received signature help request
2021-01-08 18:11:42,924 - INFO - Received completion request
2021-01-08 18:11:42,925 - DEBUG - Using filetype completion: True
2021-01-08 18:11:42,925 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:42,925 - DEBUG - TX: Sending notification: b'Content-Length: 1038\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.indexO\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":9}}}'
2021-01-08 18:11:42,925 - DEBUG - TX: Sending message: b'Content-Length: 278\r\n\r\n{"id":9,"jsonrpc":"2.0","method":"textDocument/completion","params":{"position":{"character":18,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:42,925 - INFO - Received signature help request
2021-01-08 18:11:43,092 - INFO - Received completion request
2021-01-08 18:11:43,093 - DEBUG - Using filetype completion: True
2021-01-08 18:11:43,093 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:43,093 - DEBUG - TX: Sending notification: b'Content-Length: 1040\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.indexOf\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":10}}}'
2021-01-08 18:11:43,093 - DEBUG - TX: Sending message: b'Content-Length: 279\r\n\r\n{"id":10,"jsonrpc":"2.0","method":"textDocument/completion","params":{"position":{"character":18,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:43,093 - INFO - Received signature help request
2021-01-08 18:11:43,342 - INFO - Received event notification
2021-01-08 18:11:43,342 - DEBUG - Event name: CurrentIdentifierFinished
2021-01-08 18:11:43,342 - INFO - Adding ONE buffer identifier for file: /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java
2021-01-08 18:11:43,343 - INFO - Received completion request
2021-01-08 18:11:43,343 - DEBUG - Using filetype completion: False
2021-01-08 18:11:43,344 - INFO - Received signature help request
2021-01-08 18:11:43,344 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:43,344 - DEBUG - TX: Sending notification: b'Content-Length: 1041\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.indexOf(\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":11}}}'
2021-01-08 18:11:43,344 - DEBUG - TX: Sending message: b'Content-Length: 282\r\n\r\n{"id":11,"jsonrpc":"2.0","method":"textDocument/signatureHelp","params":{"position":{"character":26,"line":17},"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java"}}}'
2021-01-08 18:11:46,509 - ERROR - Exception from semantic completer (using general)
Traceback (most recent call last):
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/handlers.py", line 123, in GetCompletions
    completions = filetype_completer.ComputeCandidates( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/completer.py", line 304, in ComputeCandidates
    candidates = self._GetCandidatesFromSubclass( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1315, in _GetCandidatesFromSubclass
    raw_completions, is_incomplete = self.ComputeCandidatesInner( request_data,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1279, in ComputeCandidatesInner
    response = self.GetConnection().GetResponse( request_id,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 442, in GetResponse
    return response.AwaitResponse( timeout )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 208, in AwaitResponse
    raise ResponseTimeoutException( 'Response Timeout' )
ycmd.completers.language_server.language_server_completer.ResponseTimeoutException: Response Timeout
2021-01-08 18:11:46,513 - INFO - Received completion request
2021-01-08 18:11:46,513 - DEBUG - Using filetype completion: False
2021-01-08 18:11:46,514 - INFO - Received signature help request
2021-01-08 18:11:46,530 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:46 Completion request completed"}}'
2021-01-08 18:11:46,530 - INFO - Server reported: 8 Jan 2021, 18:11:46 Completion request completed
2021-01-08 18:11:46,531 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","id":3,"result":{"isIncomplete":false,"items":[]}}'
2021-01-08 18:11:46,531 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:46 \\u003e\\u003e document/didChange"}}'
2021-01-08 18:11:46,531 - INFO - Server reported: 8 Jan 2021, 18:11:46 >> document/didChange
2021-01-08 18:11:46,532 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:46 \\u003e\\u003e document/completion"}}'
2021-01-08 18:11:46,532 - INFO - Server reported: 8 Jan 2021, 18:11:46 >> document/completion
2021-01-08 18:11:46,760 - ERROR - Exception from semantic completer (using general)
Traceback (most recent call last):
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/handlers.py", line 123, in GetCompletions
    completions = filetype_completer.ComputeCandidates( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/completer.py", line 304, in ComputeCandidates
    candidates = self._GetCandidatesFromSubclass( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1315, in _GetCandidatesFromSubclass
    raw_completions, is_incomplete = self.ComputeCandidatesInner( request_data,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1279, in ComputeCandidatesInner
    response = self.GetConnection().GetResponse( request_id,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 442, in GetResponse
    return response.AwaitResponse( timeout )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 208, in AwaitResponse
    raise ResponseTimeoutException( 'Response Timeout' )
ycmd.completers.language_server.language_server_completer.ResponseTimeoutException: Response Timeout
2021-01-08 18:11:46,764 - INFO - Received completion request
2021-01-08 18:11:46,764 - DEBUG - Using filetype completion: False
2021-01-08 18:11:46,764 - INFO - Received signature help request
2021-01-08 18:11:46,884 - ERROR - Exception from semantic completer (using general)
Traceback (most recent call last):
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/handlers.py", line 123, in GetCompletions
    completions = filetype_completer.ComputeCandidates( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/completer.py", line 304, in ComputeCandidates
    candidates = self._GetCandidatesFromSubclass( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1315, in _GetCandidatesFromSubclass
    raw_completions, is_incomplete = self.ComputeCandidatesInner( request_data,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1279, in ComputeCandidatesInner
    response = self.GetConnection().GetResponse( request_id,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 442, in GetResponse
    return response.AwaitResponse( timeout )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 208, in AwaitResponse
    raise ResponseTimeoutException( 'Response Timeout' )
ycmd.completers.language_server.language_server_completer.ResponseTimeoutException: Response Timeout
2021-01-08 18:11:46,938 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:46 Reconciled 0. Took 2 ms"}}'
2021-01-08 18:11:46,938 - INFO - Server reported: 8 Jan 2021, 18:11:46 Reconciled 0. Took 2 ms
2021-01-08 18:11:47,010 - ERROR - Exception from semantic completer (using general)
Traceback (most recent call last):
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/handlers.py", line 123, in GetCompletions
    completions = filetype_completer.ComputeCandidates( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/completer.py", line 304, in ComputeCandidates
    candidates = self._GetCandidatesFromSubclass( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1315, in _GetCandidatesFromSubclass
    raw_completions, is_incomplete = self.ComputeCandidatesInner( request_data,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1279, in ComputeCandidatesInner
    response = self.GetConnection().GetResponse( request_id,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 442, in GetResponse
    return response.AwaitResponse( timeout )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 208, in AwaitResponse
    raise ResponseTimeoutException( 'Response Timeout' )
ycmd.completers.language_server.language_server_completer.ResponseTimeoutException: Response Timeout
2021-01-08 18:11:47,237 - INFO - Received completion request
2021-01-08 18:11:47,237 - DEBUG - Using filetype completion: False
2021-01-08 18:11:47,238 - INFO - Received signature help request
2021-01-08 18:11:47,367 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:47 begin problem for /TestEnum.java"}}'
2021-01-08 18:11:47,367 - INFO - Server reported: 8 Jan 2021, 18:11:47 begin problem for /TestEnum.java
2021-01-08 18:11:47,367 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:47 3 problems reported for /TestEnum.java"}}'
2021-01-08 18:11:47,368 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"textDocument/publishDiagnostics","params":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","diagnostics":[{"range":{"start":{"line":17,"character":18},"end":{"line":17,"character":19}},"severity":1,"code":"1610612976","source":"Java","message":"Syntax error, insert \\") Statement\\" to complete BlockStatements"},{"range":{"start":{"line":21,"character":10},"end":{"line":21,"character":11}},"severity":1,"code":"134217858","source":"Java","message":"The constructor TestEnum.ThisIsTheEnum() is undefined"},{"range":{"start":{"line":21,"character":13},"end":{"line":21,"character":15}},"severity":1,"code":"134217858","source":"Java","message":"The constructor TestEnum.ThisIsTheEnum() is undefined"}]}}'
2021-01-08 18:11:47,368 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:47 Validated 1. Took 25 ms"}}'
2021-01-08 18:11:47,368 - INFO - Server reported: 8 Jan 2021, 18:11:47 3 problems reported for /TestEnum.java
2021-01-08 18:11:47,378 - INFO - Server reported: 8 Jan 2021, 18:11:47 Validated 1. Took 25 ms
2021-01-08 18:11:47,385 - ERROR - Exception from semantic completer (using general)
Traceback (most recent call last):
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/handlers.py", line 123, in GetCompletions
    completions = filetype_completer.ComputeCandidates( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/completer.py", line 304, in ComputeCandidates
    candidates = self._GetCandidatesFromSubclass( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1315, in _GetCandidatesFromSubclass
    raw_completions, is_incomplete = self.ComputeCandidatesInner( request_data,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1279, in ComputeCandidatesInner
    response = self.GetConnection().GetResponse( request_id,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 442, in GetResponse
    return response.AwaitResponse( timeout )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 208, in AwaitResponse
    raise ResponseTimeoutException( 'Response Timeout' )
ycmd.completers.language_server.language_server_completer.ResponseTimeoutException: Response Timeout
2021-01-08 18:11:47,390 - INFO - Received event notification
2021-01-08 18:11:47,390 - DEBUG - Event name: CurrentIdentifierFinished
2021-01-08 18:11:47,390 - INFO - Adding ONE buffer identifier for file: /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java
2021-01-08 18:11:47,632 - ERROR - Exception from semantic completer (using general)
Traceback (most recent call last):
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/handlers.py", line 123, in GetCompletions
    completions = filetype_completer.ComputeCandidates( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/completer.py", line 304, in ComputeCandidates
    candidates = self._GetCandidatesFromSubclass( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1315, in _GetCandidatesFromSubclass
    raw_completions, is_incomplete = self.ComputeCandidatesInner( request_data,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1279, in ComputeCandidatesInner
    response = self.GetConnection().GetResponse( request_id,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 442, in GetResponse
    return response.AwaitResponse( timeout )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 208, in AwaitResponse
    raise ResponseTimeoutException( 'Response Timeout' )
ycmd.completers.language_server.language_server_completer.ResponseTimeoutException: Response Timeout
2021-01-08 18:11:47,928 - ERROR - Exception from semantic completer (using general)
Traceback (most recent call last):
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/handlers.py", line 123, in GetCompletions
    completions = filetype_completer.ComputeCandidates( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/completer.py", line 304, in ComputeCandidates
    candidates = self._GetCandidatesFromSubclass( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1315, in _GetCandidatesFromSubclass
    raw_completions, is_incomplete = self.ComputeCandidatesInner( request_data,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1279, in ComputeCandidatesInner
    response = self.GetConnection().GetResponse( request_id,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 442, in GetResponse
    return response.AwaitResponse( timeout )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 208, in AwaitResponse
    raise ResponseTimeoutException( 'Response Timeout' )
ycmd.completers.language_server.language_server_completer.ResponseTimeoutException: Response Timeout
2021-01-08 18:11:47,932 - INFO - Received completion request
2021-01-08 18:11:47,932 - DEBUG - Using filetype completion: False
2021-01-08 18:11:47,933 - INFO - Received signature help request
2021-01-08 18:11:48,070 - INFO - Received event notification
2021-01-08 18:11:48,070 - DEBUG - Event name: FileReadyToParse
2021-01-08 18:11:48,070 - INFO - Adding buffer identifiers for file: /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java
2021-01-08 18:11:48,070 - DEBUG - Refreshing file /Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java: State is Open/action Change
2021-01-08 18:11:48,070 - DEBUG - TX: Sending notification: b'Content-Length: 1057\r\n\r\n{"jsonrpc":"2.0","method":"textDocument/didChange","params":{"contentChanges":[{"text":"package com.youcompleteme;\\n\\nimport java.util.Arrays;\\nimport java.util.List;\\n\\npublic class TestEnum {\\n  public interface FirstOperation {\\n    public void op( String str, char b );\\n  }\\n  public interface SecondOperation {\\n    public void op( StringBuilder b, List<String> sl );\\n  }\\n\\n  enum ThisIsTheEnum {\\n    FIRST(\\n\\n        ( str, b ) -> {\\n          if (str.indexOf()){\\n          }\\n\\n        },\\n\\n        ( b, sl ) -> {\\n\\n        }\\n\\n    ) ;\\n\\n    private ThisIsTheEnum( FirstOperation f, SecondOperation s ) {\\n      this.f = f;\\n      this.s = s;\\n    }\\n\\n    public void DoIt() {\\n      this.f.op( \\"test\\", \'b\' );\\n      this.s.op( new StringBuilder(), Arrays.asList() );\\n    }\\n\\n    private FirstOperation f;\\n    private SecondOperation s;\\n  }\\n}\\n"}],"textDocument":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","version":12}}}'
2021-01-08 18:11:48,070 - INFO - Received event notification
2021-01-08 18:11:48,071 - DEBUG - Event name: InsertLeave
2021-01-08 18:11:48,098 - ERROR - Exception from semantic completer (using general)
Traceback (most recent call last):
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/handlers.py", line 123, in GetCompletions
    completions = filetype_completer.ComputeCandidates( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/completer.py", line 304, in ComputeCandidates
    candidates = self._GetCandidatesFromSubclass( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1315, in _GetCandidatesFromSubclass
    raw_completions, is_incomplete = self.ComputeCandidatesInner( request_data,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1279, in ComputeCandidatesInner
    response = self.GetConnection().GetResponse( request_id,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 442, in GetResponse
    return response.AwaitResponse( timeout )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 208, in AwaitResponse
    raise ResponseTimeoutException( 'Response Timeout' )
ycmd.completers.language_server.language_server_completer.ResponseTimeoutException: Response Timeout
2021-01-08 18:11:48,345 - ERROR - Exception from semantic completer during sig help
Traceback (most recent call last):
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/handlers.py", line 177, in GetSignatureHelp
    signature_info = filetype_completer.ComputeSignatures( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/completer.py", line 365, in ComputeSignatures
    return self.ComputeSignaturesInner( request_data )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 1510, in ComputeSignaturesInner
    response = self.GetConnection().GetResponse( request_id,
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 442, in GetResponse
    return response.AwaitResponse( timeout )
  File "/Users/ben/.vim/bundle/YouCompleteMe-Clean/third_party/ycmd/ycmd/completers/language_server/language_server_completer.py", line 208, in AwaitResponse
    raise ResponseTimeoutException( 'Response Timeout' )
ycmd.completers.language_server.language_server_completer.ResponseTimeoutException: Response Timeout
2021-01-08 18:11:51,539 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:51 Completion request completed"}}'
2021-01-08 18:11:51,540 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","id":4,"result":{"isIncomplete":false,"items":[]}}'
2021-01-08 18:11:51,540 - INFO - Server reported: 8 Jan 2021, 18:11:51 Completion request completed
2021-01-08 18:11:51,540 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:51 \\u003e\\u003e document/didChange"}}'
2021-01-08 18:11:51,540 - INFO - Server reported: 8 Jan 2021, 18:11:51 >> document/didChange
2021-01-08 18:11:51,541 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:51 \\u003e\\u003e document/completion"}}'
2021-01-08 18:11:51,541 - INFO - Server reported: 8 Jan 2021, 18:11:51 >> document/completion
2021-01-08 18:11:51,945 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:51 Reconciled 0. Took 2 ms"}}'
2021-01-08 18:11:51,945 - INFO - Server reported: 8 Jan 2021, 18:11:51 Reconciled 0. Took 2 ms
2021-01-08 18:11:52,369 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:52 begin problem for /TestEnum.java"}}'
2021-01-08 18:11:52,369 - INFO - Server reported: 8 Jan 2021, 18:11:52 begin problem for /TestEnum.java
2021-01-08 18:11:52,369 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:52 3 problems reported for /TestEnum.java"}}'
2021-01-08 18:11:52,370 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"textDocument/publishDiagnostics","params":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","diagnostics":[{"range":{"start":{"line":17,"character":18},"end":{"line":17,"character":20}},"severity":1,"code":"1610612976","source":"Java","message":"Syntax error, insert \\") Statement\\" to complete BlockStatements"},{"range":{"start":{"line":21,"character":10},"end":{"line":21,"character":11}},"severity":1,"code":"134217858","source":"Java","message":"The constructor TestEnum.ThisIsTheEnum() is undefined"},{"range":{"start":{"line":21,"character":13},"end":{"line":21,"character":15}},"severity":1,"code":"134217858","source":"Java","message":"The constructor TestEnum.ThisIsTheEnum() is undefined"}]}}'
2021-01-08 18:11:52,370 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:52 Validated 1. Took 23 ms"}}'
2021-01-08 18:11:52,370 - INFO - Server reported: 8 Jan 2021, 18:11:52 3 problems reported for /TestEnum.java
2021-01-08 18:11:52,396 - INFO - Server reported: 8 Jan 2021, 18:11:52 Validated 1. Took 23 ms
2021-01-08 18:11:55,987 - INFO - Received debug info request
2021-01-08 18:11:56,450 - INFO - Received debug info request
2021-01-08 18:11:56,548 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:56 Completion request completed"}}'
2021-01-08 18:11:56,548 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","id":5,"result":{"isIncomplete":false,"items":[]}}'
2021-01-08 18:11:56,548 - INFO - Server reported: 8 Jan 2021, 18:11:56 Completion request completed
2021-01-08 18:11:56,548 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:56 \\u003e\\u003e document/didChange"}}'
2021-01-08 18:11:56,549 - INFO - Server reported: 8 Jan 2021, 18:11:56 >> document/didChange
2021-01-08 18:11:56,550 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:56 \\u003e\\u003e document/completion"}}'
2021-01-08 18:11:56,550 - INFO - Server reported: 8 Jan 2021, 18:11:56 >> document/completion
2021-01-08 18:11:56,682 - INFO - Received debug info request
2021-01-08 18:11:56,955 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:56 Reconciled 0. Took 1 ms"}}'
2021-01-08 18:11:56,955 - INFO - Server reported: 8 Jan 2021, 18:11:56 Reconciled 0. Took 1 ms
2021-01-08 18:11:57,378 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:57 begin problem for /TestEnum.java"}}'
2021-01-08 18:11:57,378 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:57 3 problems reported for /TestEnum.java"}}'
2021-01-08 18:11:57,379 - INFO - Server reported: 8 Jan 2021, 18:11:57 begin problem for /TestEnum.java
2021-01-08 18:11:57,379 - INFO - Server reported: 8 Jan 2021, 18:11:57 3 problems reported for /TestEnum.java
2021-01-08 18:11:57,379 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"textDocument/publishDiagnostics","params":{"uri":"file:///Users/ben/.vim/bundle/YouCompleteMe/third_party/ycmd/ycmd/tests/java/testdata/simple_eclipse_project/src/com/youcompleteme/TestEnum.java","diagnostics":[{"range":{"start":{"line":17,"character":18},"end":{"line":17,"character":21}},"severity":1,"code":"1610612976","source":"Java","message":"Syntax error, insert \\") Statement\\" to complete BlockStatements"},{"range":{"start":{"line":21,"character":10},"end":{"line":21,"character":11}},"severity":1,"code":"134217858","source":"Java","message":"The constructor TestEnum.ThisIsTheEnum() is undefined"},{"range":{"start":{"line":21,"character":13},"end":{"line":21,"character":15}},"severity":1,"code":"134217858","source":"Java","message":"The constructor TestEnum.ThisIsTheEnum() is undefined"}]}}'
2021-01-08 18:11:57,379 - DEBUG - RX: Received message: b'{"jsonrpc":"2.0","method":"window/logMessage","params":{"type":3,"message":"8 Jan 2021, 18:11:57 Validated 1. Took 21 ms"}}'
2021-01-08 18:11:57,418 - INFO - Server reported: 8 Jan 2021, 18:11:57 Validated 1. Took 21 ms
snjeza commented 3 years ago

@puremourning could you, please, attach a sample project reproducing the issue?

puremourning commented 3 years ago

jdtls-lambda-test.tar.gz

this reproduces it for me using YCM/ycmd and VSCode

puremourning commented 3 years ago
PID    COMMAND      %CPU  TIME     #TH    #WQ  #PORTS MEM    PURG   CMPRS PGRP  PPID  STATE    BOOSTS          %CPU_ME %CPU_OTHRS UID  FAULTS    COW    MSGSENT   MSGRECV   SYSBSD    SYSMACH    CSW        PAGEINS IDLEW   POWER INSTRS      CYCLES      USER
14749  java         245.8 01:48.61 56/1   1    257    638M+  0B     0B    14656 14734 running  *0[2]           0.00000 0.00000    501  285137+   560    19098     9322      529463+   58716+     269060+    0       0       245.8 7613695406  12103306136 ben
snjeza commented 3 years ago

This is an upstream issue. See https://bugs.eclipse.org/bugs/show_bug.cgi?id=570298 Case b) won't happen in Java LS. This issue is caused by the codeSelect issue (case a).

puremourning commented 3 years ago

Thanks for raising that upstream issue @snjeza

snjeza commented 3 years ago

cc @rgrunber

puremourning commented 1 year ago

I can no longer reproduce this. The completions still don't work but the spinning issue seems to have gone away.

Does that seem likely?

snjeza commented 1 year ago

The issue has been fixed upstream - https://bugs.eclipse.org/bugs/show_bug.cgi?id=570298#c3