[
https://issues.apache.org/jira/browse/SUREFIRE-1631?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16971522#comment-16971522
]
Adolfo Cia commented on SUREFIRE-1631:
--------------------------------------
[~tibordigana]
Ok, snapshot 3.0.0 didn't work:
{code:java}
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 9.047 s
[INFO] Finished at: 2019-11-11T10:15:47-03:00
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal
org.apache.maven.plugins:maven-surefire-plugin:3.0.0-SNAPSHOT:test
(default-test) on project ltl-java-linehauloperations-ensemble: There are test
failures.
[ERROR]
[ERROR] Please refer to
C:\liberty_development\workspaces\services\ltl-java-linehauloperations-ensemble\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:\liberty_development\wlp\java\java\jre\bin\java
-javaagent:C:\Users\adolfo.cia\.m2\repository/org/jmockit/jmockit/1.48/jmockit-1.48.jar
-jar
C:\Users\adolfo.cia\AppData\Local\Temp\surefire1699052172262397174\surefirebooter94309476510590017.jar
C:\Users\adolfo.cia\AppData\Local\Temp\surefire1699052172262397174
2019-11-11T10-15-44_326-jvmRun1 surefire4984701455985067123tmp
surefire_01067224024401515361tmp"
[ERROR] Error occurred in starting fork, check output in log
[ERROR] Process Exit Code: 1
[ERROR] Crashed tests:
[ERROR]
com.xpo.ltl.linehauloperations.service.ejb.v1.GetImageThumbnailMinuetTest
[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:\liberty_development\wlp\java\java\jre\bin\java
-javaagent:C:\Users\adolfo.cia\.m2\repository/org/jmockit/jmockit/1.48/jmockit-1.48.jar
-jar
C:\Users\adolfo.cia\AppData\Local\Temp\surefire1699052172262397174\surefirebooter94309476510590017.jar
C:\Users\adolfo.cia\AppData\Local\Temp\surefire1699052172262397174
2019-11-11T10-15-44_326-jvmRun1 surefire4984701455985067123tmp
surefire_01067224024401515361tmp"
[ERROR] Error occurred in starting fork, check output in log
[ERROR] Process Exit Code: 1
[ERROR] Crashed tests:
[ERROR]
com.xpo.ltl.linehauloperations.service.ejb.v1.GetImageThumbnailMinuetTest
[ERROR] at
org.apache.maven.plugin.surefire.booterclient.ForkStarter.fork(ForkStarter.java:690)
[ERROR] at
org.apache.maven.plugin.surefire.booterclient.ForkStarter.run(ForkStarter.java:285)
[ERROR] at
org.apache.maven.plugin.surefire.booterclient.ForkStarter.run(ForkStarter.java:248)
[ERROR] at
org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeProvider(AbstractSurefireMojo.java:1213)
[ERROR] at
org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeAfterPreconditionsChecked(AbstractSurefireMojo.java:1059)
[ERROR] at
org.apache.maven.plugin.surefire.AbstractSurefireMojo.execute(AbstractSurefireMojo.java:886)
[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:956)
[ERROR] at org.apache.maven.cli.MavenCli.doMain(MavenCli.java:288)
[ERROR] at org.apache.maven.cli.MavenCli.main(MavenCli.java:192)
[ERROR] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[ERROR] at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:90)
[ERROR] at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
[ERROR] at java.lang.reflect.Method.invoke(Method.java:508)
[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)
[ERROR]
[ERROR] -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e
switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please
read the following articles:
[ERROR] [Help 1]
http://cwiki.apache.org/confluence/display/MAVEN/MojoExecutionException
{code}
and the dump file:
{code:java}
# Created at 2019-11-11T10:15:47.309
Killing self fork JVM. Maven process died.
Thread dump before killing the process (21660@LAP0462):
"main"
java.lang.Thread.State: RUNNABLE
at java.util.zip.ZipFile.getEntryByModifiedUTF8(Native Method)
at java.util.zip.ZipFile.getEntry(ZipFile.java:353)
at java.util.jar.JarFile.getEntry(JarFile.java:316)
at java.util.jar.JarFile.getJarEntry(JarFile.java:299)
at sun.misc.URLClassPath$JarLoader.getResource(URLClassPath.java:1184)
at sun.misc.URLClassPath.getResource(URLClassPath.java:377)
at java.net.URLClassLoader$ClassFinder.run(URLClassLoader.java:1185)
at
java.security.AccessController.doPrivileged(AccessController.java:739)
at java.net.URLClassLoader.findClass(URLClassLoader.java:605)
at java.lang.ClassLoader.loadClassHelper(ClassLoader.java:925)
at java.lang.ClassLoader.loadClass(ClassLoader.java:870)
at java.lang.ClassLoader.loadClassHelper(ClassLoader.java:914)
at java.lang.ClassLoader.loadClass(ClassLoader.java:870)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:343)
at java.lang.ClassLoader.loadClass(ClassLoader.java:853)
at org.apache.logging.log4j.core.util.Loader.loadClass(Loader.java:241)
at
org.apache.logging.log4j.core.impl.ThrowableProxyHelper.loadClass(ThrowableProxyHelper.java:229)
at
org.apache.logging.log4j.core.impl.ThrowableProxyHelper.loadClass(ThrowableProxyHelper.java:220)
at
org.apache.logging.log4j.core.impl.ThrowableProxyHelper.toExtendedStackTrace(ThrowableProxyHelper.java:114)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:109)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:93)
at
org.apache.logging.log4j.core.impl.Log4jLogEvent.getThrownProxy(Log4jLogEvent.java:605)
at
org.apache.logging.log4j.core.pattern.ExtendedThrowablePatternConverter.format(ExtendedThrowablePatternConverter.java:63)
at
org.apache.logging.log4j.core.pattern.PatternFormatter.format(PatternFormatter.java:38)
at
org.apache.logging.log4j.core.layout.PatternLayout$PatternSerializer.toSerializable(PatternLayout.java:334)
at
org.apache.logging.log4j.core.layout.PatternLayout.toText(PatternLayout.java:233)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:218)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:58)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.directEncodeEvent(AbstractOutputStreamAppender.java:197)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.tryAppend(AbstractOutputStreamAppender.java:190)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.append(AbstractOutputStreamAppender.java:181)
at
org.apache.logging.log4j.core.config.AppenderControl.tryCallAppender(AppenderControl.java:156)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender0(AppenderControl.java:129)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppenderPreventRecursion(AppenderControl.java:120)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender(AppenderControl.java:84)
at
org.apache.logging.log4j.core.config.LoggerConfig.callAppenders(LoggerConfig.java:464)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:448)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:431)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:406)
at
org.apache.logging.log4j.core.config.DefaultReliabilityStrategy.log(DefaultReliabilityStrategy.java:49)
at org.apache.logging.log4j.core.Logger.logMessage(Logger.java:146)
at
org.apache.logging.log4j.spi.AbstractLogger.tryLogMessage(AbstractLogger.java:2170)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageTrackRecursion(AbstractLogger.java:2125)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageSafely(AbstractLogger.java:2108)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessage(AbstractLogger.java:2002)
at
org.apache.logging.log4j.spi.AbstractLogger.logIfEnabled(AbstractLogger.java:1974)
at
org.apache.logging.log4j.spi.AbstractLogger.error(AbstractLogger.java:741)
at
com.xpo.ltl.api.exception.AbstractExceptionBuilder.build(AbstractExceptionBuilder.java:236)
at
com.xpo.ltl.api.exception.AbstractApiExceptionBuilder.build(AbstractApiExceptionBuilder.java:21)
at
com.xpo.ltl.linehauloperations.service.ejb.v1.GetImageThumbNailMinuet.throwExceptionForMissingArchivedDocument(Unknown
Source)
at
com.xpo.ltl.linehauloperations.service.ejb.v1.GetImageThumbNailMinuet.getByteCodeForDocument(Unknown
Source)
at
com.xpo.ltl.linehauloperations.service.ejb.v1.GetImageThumbNailMinuet.execute(Unknown
Source)
at
com.xpo.ltl.linehauloperations.service.ejb.v1.GetImageThumbnailMinuetTest.lambda$testExecute_shouldCreateResponseWithBadTokenAndNullTokenRetryResponse$4(Unknown
Source)
at
com.xpo.ltl.linehauloperations.service.ejb.v1.GetImageThumbnailMinuetTest$$Lambda$300.000000001382A370.execute(Unknown
Source)
at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:55)
at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:37)
at org.junit.jupiter.api.Assertions.assertThrows(Assertions.java:2952)
at
com.xpo.ltl.linehauloperations.service.ejb.v1.GetImageThumbnailMinuetTest.testExecute_shouldCreateResponseWithBadTokenAndNullTokenRetryResponse(Unknown
Source)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:90)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
at java.lang.reflect.Method.invoke(Method.java:508)
at
org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:675)
at
org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
at
org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:125)
at
org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:132)
at
org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:124)
at
org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:74)
at
org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor$$Lambda$117.0000000011C453B0.apply(Unknown
Source)
at
org.junit.jupiter.engine.execution.ExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(ExecutableInvoker.java:115)
at
org.junit.jupiter.engine.execution.ExecutableInvoker$ReflectiveInterceptorCall$$Lambda$118.0000000011C48150.apply(Unknown
Source)
at
org.junit.jupiter.engine.execution.ExecutableInvoker.lambda$invoke$0(ExecutableInvoker.java:105)
at
org.junit.jupiter.engine.execution.ExecutableInvoker$$Lambda$246.0000000011CEC8D0.apply(Unknown
Source)
at
org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:104)
at
org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:62)
at
org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:43)
at
org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:35)
at
org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:104)
at
org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:98)
at
org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$6(TestMethodTestDescriptor.java:202)
at
org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor$$Lambda$275.0000000011D9CD40.execute(Unknown
Source)
at
org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at
org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:198)
at
org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:135)
at
org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:69)
at
org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:135)
at
org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda$190.0000000011CCD330.execute(Unknown
Source)
at
org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at
org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125)
at
org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda$189.0000000011CCCEB0.invoke(Unknown
Source)
at
org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135)
at
org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123)
at
org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda$188.0000000011CCCA50.execute(Unknown
Source)
at
org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
at
org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122)
at
org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80)
at
org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService$$Lambda$194.0000000011CCE460.accept(Unknown
Source)
at java.util.ArrayList.forEach(ArrayList.java:1268)
at
org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38)
at
org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139)"JIT
Compilation Thread-0"
java.lang.Thread.State: RUNNABLE"JIT Compilation Thread-1 Suspended"
java.lang.Thread.State: RUNNABLE"JIT Compilation Thread-2 Suspended"
java.lang.Thread.State: RUNNABLE"JIT Compilation Thread-3 Suspended"
java.lang.Thread.State: RUNNABLE"JIT Compilation Thread-4 Suspended"
java.lang.Thread.State: RUNNABLE"JIT Compilation Thread-5 Suspended"
java.lang.Thread.State: RUNNABLE"JIT Compilation Thread-6 Suspended"
java.lang.Thread.State: RUNNABLE"JIT Diagnostic Compilation Thread-7
Suspended"
java.lang.Thread.State: RUNNABLE"JIT-SamplerThread"
java.lang.Thread.State: TIMED_WAITING"IProfiler"
java.lang.Thread.State: RUNNABLE"Signal Dispatcher"
java.lang.Thread.State: RUNNABLE
at com.ibm.misc.SignalDispatcher.waitForSignal(Native Method)
at
com.ibm.misc.SignalDispatcher.run(SignalDispatcher.java:73)"Concurrent Mark
Helper"
java.lang.Thread.State: RUNNABLE"GC Slave"
java.lang.Thread.State: RUNNABLE"GC Slave"
java.lang.Thread.State: RUNNABLE"GC Slave"
java.lang.Thread.State: RUNNABLE"GC Slave"
java.lang.Thread.State: RUNNABLE"GC Slave"
java.lang.Thread.State: RUNNABLE"GC Slave"
java.lang.Thread.State: RUNNABLE"GC Slave"
java.lang.Thread.State: RUNNABLE"Finalizer thread"
java.lang.Thread.State: RUNNABLE"Attach API wait loop"
java.lang.Thread.State: RUNNABLE
at com.ibm.tools.attach.target.IPC.waitSemaphore(Native Method)
at
com.ibm.tools.attach.target.CommonDirectory.waitSemaphore(CommonDirectory.java:254)
at
com.ibm.tools.attach.target.WaitLoop.waitForNotification(WaitLoop.java:66)
at
com.ibm.tools.attach.target.WaitLoop.run(WaitLoop.java:154)"surefire-forkedjvm-command-thread"
java.lang.Thread.State: RUNNABLE
at java.io.FileInputStream.readBytes(Native Method)
at java.io.FileInputStream.read(FileInputStream.java:272)
at java.io.BufferedInputStream.fill(BufferedInputStream.java:257)
at java.io.BufferedInputStream.read1(BufferedInputStream.java:297)
at java.io.BufferedInputStream.read(BufferedInputStream.java:356)
at com.ibm.jvm.io.ConsoleInputStream.read(ConsoleInputStream.java:245)
at java.io.DataInputStream.readFully(DataInputStream.java:206)
at java.io.DataInputStream.readInt(DataInputStream.java:398)
at
org.apache.maven.surefire.booter.MasterProcessCommand.decode(MasterProcessCommand.java:113)
at
org.apache.maven.surefire.booter.CommandReader$CommandRunnable.run(CommandReader.java:383)
at java.lang.Thread.run(Thread.java:812)"surefire-forkedjvm-ping-30s"
java.lang.Thread.State: RUNNABLE
at
com.ibm.java.lang.management.internal.ThreadMXBeanImpl.getMultiThreadInfoImpl(Native
Method)
at
com.ibm.java.lang.management.internal.ThreadMXBeanImpl.getThreadInfo(ThreadMXBeanImpl.java:257)
at
org.apache.maven.surefire.booter.ForkedBooter.generateThreadDump(ForkedBooter.java:542)
at
org.apache.maven.surefire.booter.ForkedBooter.access$400(ForkedBooter.java:65)
at
org.apache.maven.surefire.booter.ForkedBooter$2.run(ForkedBooter.java:232)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:522)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:319)
at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:191)
at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1160)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.lang.Thread.run(Thread.java:812)"MemoryMXBean notification
dispatcher"
java.lang.Thread.State: RUNNABLE
at
com.ibm.lang.management.internal.MemoryNotificationThread.processNotificationLoop(Native
Method)
at
com.ibm.lang.management.internal.MemoryNotificationThread.run(MemoryNotificationThread.java:183)
{code}
> Forked VM terminated without properly saying goodbye with AciveMQ
> -----------------------------------------------------------------
>
> Key: SUREFIRE-1631
> URL: https://issues.apache.org/jira/browse/SUREFIRE-1631
> Project: Maven Surefire
> Issue Type: Bug
> Components: Maven Surefire Plugin
> Affects Versions: 2.20.1, 2.22.0, 3.0.0-M2, 3.0.0-M1
> Reporter: Aaron Digulla
> Assignee: Tibor Digana
> Priority: Major
> Attachments: shurefire-shutdownhook-bug-0.0.1.zip
>
>
> I'm seeing spurious "The forked VM terminated without properly saying
> goodbye. VM crash or System.exit called?" messages when running unit tests in
> a big multi-module project.
> OS: Windows 10, running Maven 3.5.0 to 3.6.0 and different versions of
> Surefire (2.20.1 to 3.0.0.-M2), Java 8u171 to 8u191.
> I'm running Maven from the command line using MinTTY (Cygwin).
> Things I tried which have no effect:
> * Reboot / Cold boot (happens first thing on Monday morning when I come into
> the office and turn on my PC).
> * More free memory (happens when I only have a single window open). I have
> 16GB of RAM.
> * Different terminal. I tried CMD prompt and urxvt (Cygwin/X).
> * Different versions of the Surefire plugin or Maven
> * Different JDK 8 builds
> Things that affect the bug:
> * Redirecting Maven's stdout to a file: mvn ... | tee mvn.log
> * Redirecting all log output to a file using logback-test.xml
> * Running Surefire with forkCount=0
> * Running a subset of the tests (-Dtest=...)
> * Pending Windows updates (I think, not sure about this one).
> Counts: I've never seen it with forkCount=0 (~ 20 test builds). I've never
> seen it with redirecting log output (~ 10 builds). Redirecting sometimes
> helps but not always.
> One thing which I notice is that one of the tests creates an ActiveMQ broker
> and uses a shutdown hook to stop it. So I created a small test project which
> demonstrates that Surefire will sometimes cut off stdout. I think that
> happens because the main process kills the child after a timeout (correct?).
> So my guess would be that shutdown hooks can mess with the pipeline between
> the surefire child VM and main Maven process. ActiveMQ might be worse since
> it stops threads and execution pools (so the output comes slowly with a
> couple of exceptions sprinkled in when one component loses connection because
> another is shutting down).
> But now, it gets weird. When the build succeeds, it takes about ~5 minutes to
> run 1028 tests. The log is 25 MB.
> When it fails, it takes ~8 minutes to run ~700-800 tests (this number varies)
> and the log stops in the middle of a test but is also 25 MB.
> Some of the time discrepancy is probably because writing to a file is faster
> than printing on a terminal. The strange part is that the log file is about
> the same size but 30% of the tests haven't run. Most tests log a lot, do I
> would expect to see a difference of at least a few MB. The Maven part (which
> contains escape sequences, etc). is just 60 KB.
> Maybe the parent takes some part of the log output as "child terminated".
> I'm running out of ideas what to try next. I think a way to log the
> communication between parent and child would help. Also the parent should
> terminate the child and then read stdout until EOF to we can see anything
> that happens afterwards.
--
This message was sent by Atlassian Jira
(v8.3.4#803005)
