René's URL Explorer Experiment

{"@context":"https://schema.org","@type":"DiscussionForumPosting","headline":"`ProtocolNotBoundException` exception when importing libraries in IDEA","articleBody":"**Description**\r\n\r\nThe following exception has fallen into IDEA when Generate tests action had been initiated before import libraries and indexing in IDEA process finished:\r\n`com.jetbrains.rd.framework.base.ProtocolNotBoundException: Server.EngineProcessModel.obtainClassId::\u003c\u003cunbound\u003e\u003e is not bound to a protocol`\r\n\r\n**To Reproduce**\r\n\r\n1. The following `settings.properties` was used: \r\n\r\n`logConcreteExecutionErrors=true\r\ninstrumentedProcessLogLevel=Debug`\r\n\r\n2. Run the 'UTBotJava' project in IntelliJ Idea\r\n3. Install [one of the latest plugins built from main](https://github.com/UnitTestBot/UTBotJava/actions/runs/3551969726)\r\n4. Checkout main version from 3 days ago (to initiate import and indexing process lasting long)\r\n5. Start test generation for 1-2 samples (static mocking was selected)\r\n\r\n**Expected behavior**\r\n\r\nNo exception is supposed to fall down to IDE.\r\n\r\n**Actual behavior**\r\n\r\n\u003csummary\u003e\r\nProtocolNotBoundException: Server.EngineProcessModel.obtainClassId::\u003c\u003cunbound\u003e\u003e is not bound to a protocol\r\n\u003c/summary\u003e\r\n\u003cdetails\u003e\r\ncom.jetbrains.rd.framework.base.ProtocolNotBoundException: Server.EngineProcessModel.obtainClassId::\u003c\u003cunbound\u003e\u003e is not bound to a protocol\r\n\tat com.jetbrains.rd.framework.base.RdBindableBase.nb(RdBindableBase.kt:52)\r\n\tat com.jetbrains.rd.framework.base.RdBindableBase.getProtocol(RdBindableBase.kt:36)\r\n\tat com.jetbrains.rd.framework.impl.RdCall.createResponseScheduler(RdTask.kt:264)\r\n\tat com.jetbrains.rd.framework.impl.RdCall.startSuspending(RdTask.kt:258)\r\n\tat com.jetbrains.rd.framework.IRdCall$DefaultImpls.startSuspending(TaskInterfaces.kt:167)\r\n\tat com.jetbrains.rd.framework.impl.RdCall.startSuspending(RdTask.kt:186)\r\n\tat com.jetbrains.rd.framework.IRdCall$DefaultImpls.startSuspending$default(TaskInterfaces.kt:167)\r\n\tat org.utbot.rd.UtRdUtilKt$startBlocking$1.invokeSuspend(UtRdUtil.kt:30)\r\n\tat kotlin.coroutines.jvm.internal.BaseContinuationImpl.resumeWith(ContinuationImpl.kt:33)\r\n\tat kotlinx.coroutines.DispatchedTask.run(DispatchedTask.kt:106)\r\n\tat kotlinx.coroutines.EventLoopImplBase.processNextEvent(EventLoop.common.kt:284)\r\n\tat kotlinx.coroutines.BlockingCoroutine.joinBlocking(Builders.kt:85)\r\n\tat kotlinx.coroutines.BuildersKt__BuildersKt.runBlocking(Builders.kt:59)\r\n\tat kotlinx.coroutines.BuildersKt.runBlocking(Unknown Source)\r\n\tat kotlinx.coroutines.BuildersKt__BuildersKt.runBlocking$default(Builders.kt:38)\r\n\tat kotlinx.coroutines.BuildersKt.runBlocking$default(Unknown Source)\r\n\tat org.utbot.rd.UtRdUtilKt.startBlocking(UtRdUtil.kt:30)\r\n\tat org.utbot.intellij.plugin.process.EngineProcess.obtainClassId(EngineProcess.kt:200)\r\n\tat org.utbot.intellij.plugin.generator.UtTestsDialogProcessor$createTests$1$1$run$1$2.compute(UtTestsDialogProcessor.kt:173)\r\n\tat org.utbot.intellij.plugin.generator.UtTestsDialogProcessor$createTests$1$1$run$1$2.compute(UtTestsDialogProcessor.kt:171)\r\n\tat com.intellij.openapi.project.DumbService.lambda$runReadActionInSmartMode$0(DumbService.java:113)\r\n\tat com.intellij.openapi.project.DumbService.lambda$runReadActionInSmartMode$1(DumbService.java:157)\r\n\tat com.intellij.openapi.application.impl.ApplicationImpl.runReadAction(ApplicationImpl.java:941)\r\n\tat com.intellij.openapi.application.ReadAction.compute(ReadAction.java:68)\r\n\tat com.intellij.openapi.project.DumbService.runReadActionInSmartMode(DumbService.java:150)\r\n\tat com.intellij.openapi.project.DumbService.runReadActionInSmartMode(DumbService.java:113)\r\n\tat org.utbot.intellij.plugin.generator.UtTestsDialogProcessor$createTests$1$1.run(UtTestsDialogProcessor.kt:171)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.startTask(CoreProgressManager.java:442)\r\n\tat com.intellij.openapi.progress.impl.ProgressManagerImpl.startTask(ProgressManagerImpl.java:114)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.lambda$runProcessWithProgressAsynchronously$5(CoreProgressManager.java:493)\r\n\tat com.intellij.openapi.progress.impl.ProgressRunner.lambda$submit$3(ProgressRunner.java:252)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.lambda$runProcess$2(CoreProgressManager.java:188)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.lambda$executeProcessUnderProgress$12(CoreProgressManager.java:608)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.registerIndicatorAndRun(CoreProgressManager.java:683)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.computeUnderProgress(CoreProgressManager.java:639)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.executeProcessUnderProgress(CoreProgressManager.java:607)\r\n\tat com.intellij.openapi.progress.impl.ProgressManagerImpl.executeProcessUnderProgress(ProgressManagerImpl.java:60)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.runProcess(CoreProgressManager.java:175)\r\n\tat com.intellij.openapi.progress.impl.ProgressRunner.lambda$submit$4(ProgressRunner.java:252)\r\n\tat java.base/java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1768)\r\n\tat java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)\r\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)\r\n\tat java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1$1.run(Executors.java:702)\r\n\tat java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1$1.run(Executors.java:699)\r\n\tat java.base/java.security.AccessController.doPrivileged(AccessController.java:399)\r\n\tat java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1.run(Executors.java:699)\r\n\tat java.base/java.lang.Thread.run(Thread.java:833)\r\n\u003c/details\u003e\r\n\r\n**Visual proofs (screenshots, logs, images)**\r\n\r\n\u003csummary\u003e\r\nidea.log\r\n\u003c/summary\u003e\r\n\u003cdetails\u003e\r\n2022-11-28 16:10:10,487 [1609496]   INFO - STDOUT - Locked\r\n2022-11-28 16:10:10,567 [1609576]   INFO - STDOUT - Engine process started with PID = 16012\r\n2022-11-28 16:10:10,569 [1609578]   INFO - STDOUT - Engine process log file - C:\\Users\\lWX1182794\\AppData\\Local\\Temp\\UTBot\\rdEngineProcessLogs\\28-11-2022_16-10-10.log\r\n2022-11-28 16:10:10,573 [1609582]   INFO - STDOUT - RdCoroutineHost overridden \r\n2022-11-28 16:10:15,660 [1614669]   INFO - #c.j.p.intellij-plugin - [3, source=INIT] ProjectDataProvider#fetchInfoFor() - Failed obtaining data for 8 dependencies\r\n2022-11-28 16:11:17,728 [1676737]   WARN - #c.i.u.x.Binding - no accessors for org.jetbrains.idea.perforce.perforce.ConnectionId\r\n2022-11-28 16:11:17,759 [1676768]   INFO - #c.i.c.ComponentStoreImpl - Saving Project(name=utbot, containerState=COMPONENT_CREATED, componentStore=C:\\Users\\lWX1182794\\UTBotJava)GradleLocalSettings took 11 ms\r\n2022-11-28 16:12:17,919 [1736928]   INFO - STDOUT - ServerSocket: start terminating lifetime \r\n2022-11-28 16:12:18,434 [1737443]   INFO - STDOUT - ServerSocket: termination finished \r\n\r\n2022-11-28 16:12:56,772 [1775781]   INFO - STDOUT - Unlocked\r\n2022-11-28 16:12:56,875 [1775884] SEVERE - #c.i.o.p.Task - Server.EngineProcessModel.obtainClassId::\u003c\u003cunbound\u003e\u003e is not bound to a protocol\r\ncom.jetbrains.rd.framework.base.ProtocolNotBoundException: Server.EngineProcessModel.obtainClassId::\u003c\u003cunbound\u003e\u003e is not bound to a protocol\r\n\tat com.jetbrains.rd.framework.base.RdBindableBase.nb(RdBindableBase.kt:52)\r\n\tat com.jetbrains.rd.framework.base.RdBindableBase.getProtocol(RdBindableBase.kt:36)\r\n\tat com.jetbrains.rd.framework.impl.RdCall.createResponseScheduler(RdTask.kt:264)\r\n\tat com.jetbrains.rd.framework.impl.RdCall.startSuspending(RdTask.kt:258)\r\n\tat com.jetbrains.rd.framework.IRdCall$DefaultImpls.startSuspending(TaskInterfaces.kt:167)\r\n\tat com.jetbrains.rd.framework.impl.RdCall.startSuspending(RdTask.kt:186)\r\n\tat com.jetbrains.rd.framework.IRdCall$DefaultImpls.startSuspending$default(TaskInterfaces.kt:167)\r\n\tat org.utbot.rd.UtRdUtilKt$startBlocking$1.invokeSuspend(UtRdUtil.kt:30)\r\n\tat kotlin.coroutines.jvm.internal.BaseContinuationImpl.resumeWith(ContinuationImpl.kt:33)\r\n\tat kotlinx.coroutines.DispatchedTask.run(DispatchedTask.kt:106)\r\n\tat kotlinx.coroutines.EventLoopImplBase.processNextEvent(EventLoop.common.kt:284)\r\n\tat kotlinx.coroutines.BlockingCoroutine.joinBlocking(Builders.kt:85)\r\n\tat kotlinx.coroutines.BuildersKt__BuildersKt.runBlocking(Builders.kt:59)\r\n\tat kotlinx.coroutines.BuildersKt.runBlocking(Unknown Source)\r\n\tat kotlinx.coroutines.BuildersKt__BuildersKt.runBlocking$default(Builders.kt:38)\r\n\tat kotlinx.coroutines.BuildersKt.runBlocking$default(Unknown Source)\r\n\tat org.utbot.rd.UtRdUtilKt.startBlocking(UtRdUtil.kt:30)\r\n\tat org.utbot.intellij.plugin.process.EngineProcess.obtainClassId(EngineProcess.kt:200)\r\n\tat org.utbot.intellij.plugin.generator.UtTestsDialogProcessor$createTests$1$1$run$1$2.compute(UtTestsDialogProcessor.kt:173)\r\n\tat org.utbot.intellij.plugin.generator.UtTestsDialogProcessor$createTests$1$1$run$1$2.compute(UtTestsDialogProcessor.kt:171)\r\n\tat com.intellij.openapi.project.DumbService.lambda$runReadActionInSmartMode$0(DumbService.java:113)\r\n\tat com.intellij.openapi.project.DumbService.lambda$runReadActionInSmartMode$1(DumbService.java:157)\r\n\tat com.intellij.openapi.application.impl.ApplicationImpl.runReadAction(ApplicationImpl.java:941)\r\n\tat com.intellij.openapi.application.ReadAction.compute(ReadAction.java:68)\r\n\tat com.intellij.openapi.project.DumbService.runReadActionInSmartMode(DumbService.java:150)\r\n\tat com.intellij.openapi.project.DumbService.runReadActionInSmartMode(DumbService.java:113)\r\n\tat org.utbot.intellij.plugin.generator.UtTestsDialogProcessor$createTests$1$1.run(UtTestsDialogProcessor.kt:171)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.startTask(CoreProgressManager.java:442)\r\n\tat com.intellij.openapi.progress.impl.ProgressManagerImpl.startTask(ProgressManagerImpl.java:114)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.lambda$runProcessWithProgressAsynchronously$5(CoreProgressManager.java:493)\r\n\tat com.intellij.openapi.progress.impl.ProgressRunner.lambda$submit$3(ProgressRunner.java:252)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.lambda$runProcess$2(CoreProgressManager.java:188)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.lambda$executeProcessUnderProgress$12(CoreProgressManager.java:608)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.registerIndicatorAndRun(CoreProgressManager.java:683)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.computeUnderProgress(CoreProgressManager.java:639)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.executeProcessUnderProgress(CoreProgressManager.java:607)\r\n\tat com.intellij.openapi.progress.impl.ProgressManagerImpl.executeProcessUnderProgress(ProgressManagerImpl.java:60)\r\n\tat com.intellij.openapi.progress.impl.CoreProgressManager.runProcess(CoreProgressManager.java:175)\r\n\tat com.intellij.openapi.progress.impl.ProgressRunner.lambda$submit$4(ProgressRunner.java:252)\r\n\tat java.base/java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1768)\r\n\tat java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)\r\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)\r\n\tat java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1$1.run(Executors.java:702)\r\n\tat java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1$1.run(Executors.java:699)\r\n\tat java.base/java.security.AccessController.doPrivileged(AccessController.java:399)\r\n\tat java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1.run(Executors.java:699)\r\n\tat java.base/java.lang.Thread.run(Thread.java:833)\r\n2022-11-28 16:12:56,876 [1775885] SEVERE - #c.i.o.p.Task - IntelliJ IDEA 2022.2.3  Build #IU-222.4345.14\r\n2022-11-28 16:12:56,876 [1775885] SEVERE - #c.i.o.p.Task - JDK: 17.0.4.1; VM: OpenJDK 64-Bit Server VM; Vendor: JetBrains s.r.o.\r\n2022-11-28 16:12:56,876 [1775885] SEVERE - #c.i.o.p.Task - OS: Windows 10\r\n2022-11-28 16:12:56,877 [1775886] SEVERE - #c.i.o.p.Task - Plugin to blame: UnitTestBot version: 2022.11.563.\r\n\r\n\u003c/details\u003e\r\n\r\n\u003csummary\u003e\r\n28-11-2022_16-10-10.log\r\n\u003c/summary\u003e\r\n\u003cdetails\u003e\r\n16:10:11.627 | INFO  | EngineProcessMain         | RdCWARNING: Illegal reflective access by com.esotericsoftware.kryo.kryo5.unsafe.UnsafeUtil (file:/C:/Users/lWX1182794/AppData/Roaming/JetBrains/IntelliJIdea2022.2/plugins/utbot-intellij/lib/kryo5-5.3.0.jar) to constructor java.nio.DirectByteBuffer(long,int)\r\nWARNING: Illegal reflective access by com.esotericsoftware.kryo.kryo5.unsafe.UnsafeUtil (file:/C:/Users/lWX1182794/AppData/Roaming/JetBrains/IntelliJIdea2022.2/plugins/utbot-intellij/lib/kryo5-5.3.0.jar) to method sun.nio.ch.DirectBuffer.cleaner()\r\n ClientSocket : connected \r\n16:10:11.697 | DEBUG | EngineProcessMain         | RESUME :: {id = ClientSocket/Sender, state = 'AsyncProcessing'} \r\n16:10:11.795 | INFO  | EngineProcessMain         | signalled \r\n16:10:12.010 | INFO  | AnalyticsConfigureUtil    | PathSelectorType: INHERITORS_SELECTOR\r\n16:12:17.802 | INFO  | EngineProcessMain         | terminating lifetime by timeout \r\n16:12:17.807 | INFO  | EngineProcessMain         | runBlocking ending\r\n16:12:17.807 | INFO  | EngineProcessMain         | ClientSocket: start terminating lifetime \r\n16:12:17.807 | DEBUG | EngineProcessMain         | ClientSocket: shutting down ack sending executor \r\n16:12:17.807 | INFO  | EngineProcessMain         | runBlocking ended\r\n16:12:17.808 | DEBUG | EngineProcessMain         | ClientSocket: send buffer stopped, success: true \r\n16:12:17.808 | DEBUG | EngineProcessMain         | ClientSocket: closing socket \r\n16:12:17.809 | DEBUG | EngineProcessMain         | ClientSocket: waiting for receiver thread \r\n16:12:17.809 | DEBUG | EngineProcessMain         | Exception in SocketWire.Receive:  ClientSocket: java.net.SocketException: Socket closed \r\n16:12:17.811 | DEBUG | EngineProcessMain         | ClientSocket: receiverProc finished  \r\n16:12:17.811 | DEBUG | EngineProcessMain         | ClientSocket: terminated. \r\n16:12:17.811 | INFO  | EngineProcessMain         | ClientSocket: termination finished \r\n\u003c/details\u003e\r\n\r\n**Environment**\r\n\r\nWindows 10 Pro\r\nIntelliJ IDEA 2022.2.2\r\nGradle \r\nJDK 11\r\n\r\n**Additional context**\r\n\r\njavaw.exe process was terminated (checked in Task Manager)\r\n","author":{"url":"https://github.com/alisevych","@type":"Person","name":"alisevych"},"datePublished":"2022-11-28T13:33:45.000Z","interactionStatistic":{"@type":"InteractionCounter","interactionType":"https://schema.org/CommentAction","userInteractionCount":1},"url":"https://github.com/1433/UTBotJava/issues/1433"}