You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@nlpcraft.apache.org by "Aaron Radzinski (Jira)" <ji...@apache.org> on 2021/01/30 03:52:00 UTC
[jira] [Assigned] (NLPCRAFT-76) Test failure on Windows.
[ https://issues.apache.org/jira/browse/NLPCRAFT-76?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Aaron Radzinski reassigned NLPCRAFT-76:
---------------------------------------
Assignee: Sergey Kamov (was: Aaron Radzinski)
> Test failure on Windows.
> ------------------------
>
> Key: NLPCRAFT-76
> URL: https://issues.apache.org/jira/browse/NLPCRAFT-76
> Project: NLPCraft
> Issue Type: Bug
> Components: test
> Affects Versions: 0.6.2
> Reporter: Paul King
> Assignee: Sergey Kamov
> Priority: Major
> Fix For: 0.7.5
>
>
> Examples from 0.7.3:
> {noformat}
> [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.22.1:test (integration-tests) on project nlpcraft: There are test failures.
> [ERROR]
> [ERROR] Please refer to D:\tmp\nlpcraft\073\apache-nlpcraft\nlpcraft\target\surefire-reports for the individual test results.
> [ERROR] Please refer to dump files (if any exist) [date].dump, [date]-jvmRun[N].dump and [date].dumpstream.
> [ERROR] The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
> [ERROR] Command was cmd.exe /X /C "C:\Progra~1\AdoptOpenJDK\jdk-11.0.8.10-hotspot\bin\java -jar "C:\Users\Paul King\AppData\Local\Temp\surefire7851445059229675487\surefirebooter6212500639838130057.jar" "C:\Users\Paul King\AppData\Local\Temp\surefire7851445059229675487" 2021-01-18T18-48-51_629-jvmRun1 surefire17512347805813647919tmp surefire_0900453059839016198tmp"
> [ERROR] Process Exit Code: 0
> [ERROR] Crashed tests:
> [ERROR] org.apache.nlpcraft.server.rest.NCRestAskSpec
> [ERROR] org.apache.maven.surefire.booter.SurefireBooterForkException: The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
> {noformat}
> {noformat}
> [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.22.1:test (integration-tests) on project nlpcraft: There are test failures.
> [ERROR]
> [ERROR] Please refer to D:\tmp\nlpcraft\073\apache-nlpcraft\nlpcraft\target\surefire-reports for the individual test results.
> [ERROR] Please refer to dump files (if any exist) [date].dump, [date]-jvmRun[N].dump and [date].dumpstream.
> [ERROR] The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
> [ERROR] Command was cmd.exe /X /C "C:\Progra~1\AdoptOpenJDK\jdk-11.0.8.10-hotspot\bin\java -jar "C:\Users\Paul King\AppData\Local\Temp\surefire3495260889293679007\surefirebooter12040527775344534193.jar"
> "C:\Users\Paul King\AppData\Local\Temp\surefire3495260889293679007" 2021-01-18T18-54-27_237-jvmRun1 surefire6023894785853744471tmp surefire_02137409296786047525tmp"
> [ERROR] Process Exit Code: 0
> [ERROR] Crashed tests:
> [ERROR] org.apache.nlpcraft.probe.mgrs.nlp.enrichers.sort.NCEnricherSortSpec
> [ERROR] org.apache.maven.surefire.booter.SurefireBooterForkException: The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
> {noformat}
> Latest example with 0.7.4:
> {noformat}
> [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.22.1:test (integration-tests) on project nlpcraft: There are test failures.
> [ERROR]
> [ERROR] Please refer to D:\tmp\nlpcraft\074\apache-nlpcraft\nlpcraft\target\surefire-reports for the individual test results.
> [ERROR] Please refer to dump files (if any exist) [date].dump, [date]-jvmRun[N].dump and [date].dumpstream.
> [ERROR] The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
> [ERROR] Command was cmd.exe /X /C "C:\Progra~1\AdoptOpenJDK\jdk-11.0.8.10-hotspot\bin\java -jar "C:\Users\Paul King\AppData\Local\Temp\surefire5859117010280734854\surefirebooter7065006848197721739.jar" "C:\Users\Paul King\AppData\Local\Temp\surefire5859117010280734854" 2021-01-28T14-51-44_521-jvmRun1 surefire10986047377906380386tmp surefire_02218379737656475030tmp"
> [ERROR] Process Exit Code: 0
> [ERROR] Crashed tests:
> [ERROR] org.apache.nlpcraft.server.rest.NCRestAskSpec
> [ERROR] org.apache.maven.surefire.booter.SurefireBooterForkException: The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
> [ERROR] Command was cmd.exe /X /C "C:\Progra~1\AdoptOpenJDK\jdk-11.0.8.10-hotspot\bin\java -jar "C:\Users\Paul King\AppData\Local\Temp\surefire5859117010280734854\surefirebooter7065006848197721739.jar" "C:\Users\Paul King\AppData\Local\Temp\surefire5859117010280734854" 2021-01-28T14-51-44_521-jvmRun1 surefire10986047377906380386tmp surefire_02218379737656475030tmp"
> [ERROR] Process Exit Code: 0
> [ERROR] Crashed tests:
> [ERROR] org.apache.nlpcraft.server.rest.NCRestAskSpec
> [ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.fork(ForkStarter.java:669)
> [ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.run(ForkStarter.java:282)
> [ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.run(ForkStarter.java:245)
> [ERROR] at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeProvider(AbstractSurefireMojo.java:1183)
> [ERROR] at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeAfterPreconditionsChecked(AbstractSurefireMojo.java:1011)
> [ERROR] at org.apache.maven.plugin.surefire.AbstractSurefireMojo.execute(AbstractSurefireMojo.java:857)
> [ERROR] at org.apache.maven.plugin.DefaultBuildPluginManager.executeMojo(DefaultBuildPluginManager.java:137)
> [ERROR] at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:210)
> [ERROR] at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:156)
> [ERROR] at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:148)
> [ERROR] at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:117)
> [ERROR] at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:81)
> [ERROR] at org.apache.maven.lifecycle.internal.builder.singlethreaded.SingleThreadedBuilder.build(SingleThreadedBuilder.java:56)
> [ERROR] at org.apache.maven.lifecycle.internal.LifecycleStarter.execute(LifecycleStarter.java:128)
> [ERROR] at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:305)
> [ERROR] at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:192)
> [ERROR] at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:105)
> [ERROR] at org.apache.maven.cli.MavenCli.execute(MavenCli.java:957)
> [ERROR] at org.apache.maven.cli.MavenCli.doMain(MavenCli.java:289)
> [ERROR] at org.apache.maven.cli.MavenCli.main(MavenCli.java:193)
> [ERROR] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> [ERROR] at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> [ERROR] at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> [ERROR] at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> [ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.launchEnhanced(Launcher.java:282)
> [ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.launch(Launcher.java:225)
> [ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.mainWithExitCode(Launcher.java:406)
> [ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.main(Launcher.java:347)
> {noformat}
> Server log has a few entries like below (might be totally unrelated):
> {noformat}
> ...
> Jan-28|14:42:32|ERR| Failed to process selector key [ses=GridSelectorNioSessionImpl [worker=DirectNioClientWorker [super=AbstractNioClientWorker [idx=0, bytesRcvd=0, bytesSent=0, bytesRcvd0=0, bytesSent0=0, select=true, super=GridWorker [name=grid-nio-worker-tcp-comm-0, igniteInstanceName=nlpcraft, finished=false, heartbeatTs=1611808951507, hashCode=925522753, interrupted=false, runner=grid-nio-worker-tcp-comm-0-#31%nlpcraft%]]], writeBuf=java.nio.DirectByteBuffer[pos=0 lim=18 cap=32768], readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768], inRecovery=null, outRecovery=null, closeSocket=true, outboundMessagesQueueSizeMetric=o.a.i.i.processors.metric.impl.LongAdderMetric@69a257d1, super=GridNioSessionImpl [locAddr=/127.0.0.1:47100, rmtAddr=/127.0.0.1:54174, createTime=1611808951317, closeTime=0, bytesSent=0, bytesRcvd=0, bytesSent0=0, bytesRcvd0=0, sndSchedTime=1611808951317, lastSndTime=1611808951317, lastRcvTime=1611808951317, readsPaused=false, filterChain=FilterChain[filters=[GridNioCodecFilter [parser=o.a.i.i.util.nio.GridDirectParser@5c2895c8, directMode=true], GridConnectionBytesVerifyFilter], accepted=true, markedForClose=false]]]
> java.io.IOException: An existing connection was forcibly closed by the remote host
> at sun.nio.ch.SocketDispatcher.write0(Native Method) ~[?:?]
> at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:51) ~[?:?]
> at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:113) ~[?:?]
> at sun.nio.ch.IOUtil.write(IOUtil.java:58) ~[?:?]
> at sun.nio.ch.IOUtil.write(IOUtil.java:50) ~[?:?]
> at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:466) ~[?:?]
> at org.apache.ignite.internal.util.nio.GridNioServer$DirectNioClientWorker.processWrite0(GridNioServer.java:1708) ~[apache-nlpcraft-incubating-0.7.4-all-deps.jar:0.7.4]
> at org.apache.ignite.internal.util.nio.GridNioServer$DirectNioClientWorker.processWrite(GridNioServer.java:1386) ~[apache-nlpcraft-incubating-0.7.4-all-deps.jar:0.7.4]
> at org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.processSelectedKeysOptimized(GridNioServer.java:2481) [apache-nlpcraft-incubating-0.7.4-all-deps.jar:0.7.4]
> at org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.bodyInternal(GridNioServer.java:2243) [apache-nlpcraft-incubating-0.7.4-all-deps.jar:0.7.4]
> at org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.body(GridNioServer.java:1880) [apache-nlpcraft-incubating-0.7.4-all-deps.jar:0.7.4]
> at org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:120) [apache-nlpcraft-incubating-0.7.4-all-deps.jar:0.7.4]
> at java.lang.Thread.run(Thread.java:834) [?:?]
> Jan-28|14:42:32|WRN| Client disconnected abruptly due to network connection loss or because the connection was left open on application shutdown. [cls=class o.a.i.i.util.nio.GridNioException, msg=An existing connection was forcibly closed by the remote host]
> ...
> {noformat}
> Dump files (might be totally unrelated):
> {noformat}
> ...
> # Created at 2021-01-28T14:51:05.974
> System.exit() or native command error interrupted process checker.
> java.lang.IllegalStateException: Cannot use PPID 1821040 process information. Going to use NOOP events.
> at org.apache.maven.surefire.booter.PpidChecker.checkProcessInfo(PpidChecker.java:155)
> at org.apache.maven.surefire.booter.PpidChecker.isProcessAlive(PpidChecker.java:116)
> at org.apache.maven.surefire.booter.ForkedBooter$2.run(ForkedBooter.java:214)
> at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
> at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
> at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305)
> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
> at java.base/java.lang.Thread.run(Thread.java:834)
> # Created at 2021-01-28T14:52:02.205
> Killing self fork JVM. PING timeout elapsed.
> ...
> ============8<==============
> ...
> # Created at 2021-01-28T14:51:04.278
> TestSet has not finished before stream error has appeared >> initializing exit by non-null configuration: null
> java.io.EOFException
> at java.base/java.io.DataInputStream.readInt(DataInputStream.java:397)
> at org.apache.maven.surefire.booter.MasterProcessCommand.decode(MasterProcessCommand.java:115)
> at org.apache.maven.surefire.booter.CommandReader$CommandRunnable.run(CommandReader.java:391)
> at java.base/java.lang.Thread.run(Thread.java:834)
> # Created at 2021-01-28T14:51:08.582
> Unexpected IOException with stream: Jan.-28|14:51:08|INF| NCService - (NCService.scala:147) - NCDialogFlowManager stopped.
> ...
> {noformat}
> Winver:
> {noformat}
> Version 20H2 (OS Build 19042.685)
> {noformat}
> Java version:
> {noformat}
> openjdk version "11.0.8" 2020-07-14
> OpenJDK Runtime Environment AdoptOpenJDK (build 11.0.8+10)
> OpenJDK 64-Bit Server VM AdoptOpenJDK (build 11.0.8+10, mixed mode)
> {noformat}
> ENV:
> {noformat}
> PATH=C:\devtools\apache-maven-3.6.3\bin;C:\Progra~1\AdoptOpenJDK\jdk-11.0.8.10-hotspot\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\system32\Wbem;c:\devtools
> JAVA_HOME=C:\Progra~1\AdoptOpenJDK\jdk-11.0.8.10-hotspot
> M2_HOME=C:\devtools\apache-maven-3.6.3
> {noformat}
--
This message was sent by Atlassian Jira
(v8.3.4#803005)