You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@maven.apache.org by "Liam Sharp (JIRA)" <ji...@apache.org> on 2018/05/08 08:57:00 UTC

[jira] [Created] (SUREFIRE-1519) intermittent "VM terminated without properly saying goodbye" failures

Liam Sharp created SUREFIRE-1519:
------------------------------------

             Summary: intermittent "VM terminated without properly saying goodbye" failures
                 Key: SUREFIRE-1519
                 URL: https://issues.apache.org/jira/browse/SUREFIRE-1519
             Project: Maven Surefire
          Issue Type: Bug
    Affects Versions: 2.20.1
         Environment: Windows 10 - works for me on MacOS 10.13 and Ubuntu 16.04.
            Reporter: Liam Sharp
         Attachments: Repro.cmd, Repro.ps1

Unit tests for the products I work on started failing when we revved surefire from 2.11 to 2.21.0. The fails are not 100% reproducible, you have to run the tests a number (can be 1-50!) to get this to happen. I've isolated this down into the following test project:

https://github.com/liamsharp/surefireissue

Here's the failure:

09:41:03,766 [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.21.0:test (default-test) on project surefireissue: There are test failures.
09:41:03,768 [ERROR]
09:41:03,768 [ERROR] Please refer to C:\Users\frogbuild\Documents\liam\surefireissue\surefireissue\target\surefire-reports for the individual test results.
09:41:03,768 [ERROR] Please refer to dump files (if any exist) [date]-jvmRun[N].dump, [date].dumpstream and [date]-jvmRun[N].dumpstream.
09:41:03,768 [ERROR] The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
09:41:03,768 [ERROR] Command was cmd.exe /X /C ""C:\Program Files\Java\jdk1.8.0_60\jre\bin\java" -jar C:\Users\FROGBU~1\AppData\Local\Temp\surefire1120183380627548027\surefirebooter767033244453552089.jar C:\Users\frogbuild\AppData\Local\Temp\surefire1120183380627548027 2018-05-08T09-39-25_823-jvmRun1 surefire7456056910433873349tmp surefire_08747097102987660469tmp"
09:41:03,769 [ERROR] Error occurred in starting fork, check output in log
09:41:03,769 [ERROR] Process Exit Code: 1
09:41:03,769 [ERROR] Crashed tests:
09:41:03,769 [ERROR] com.github.liamsharp.AppTest
09:41:03,770 [ERROR] org.apache.maven.surefire.booter.SurefireBooterForkException: The forked VM terminated without properly saying goodbye. VM crash or System.exit called?
09:41:03,773 [ERROR] Command was cmd.exe /X /C ""C:\Program Files\Java\jdk1.8.0_60\jre\bin\java" -jar C:\Users\FROGBU~1\AppData\Local\Temp\surefire1120183380627548027\surefirebooter767033244453552089.jar C:\Users\frogbuild\AppData\Local\Temp\surefire1120183380627548027 2018-05-08T09-39-25_823-jvmRun1 surefire7456056910433873349tmp surefire_08747097102987660469tmp"
09:41:03,773 [ERROR] Error occurred in starting fork, check output in log
09:41:03,773 [ERROR] Process Exit Code: 1
09:41:03,773 [ERROR] Crashed tests:
09:41:03,774 [ERROR] com.github.liamsharp.AppTest
09:41:03,774 [ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.fork(ForkStarter.java:671)
09:41:03,774 [ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.fork(ForkStarter.java:533)
09:41:03,775 [ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.run(ForkStarter.java:278)
09:41:03,775 [ERROR] at org.apache.maven.plugin.surefire.booterclient.ForkStarter.run(ForkStarter.java:244)
09:41:03,775 [ERROR] at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeProvider(AbstractSurefireMojo.java:1149)
09:41:03,775 [ERROR] at org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeAfterPreconditionsChecked(AbstractSurefireMojo.java:978)
09:41:03,776 [ERROR] at org.apache.maven.plugin.surefire.AbstractSurefireMojo.execute(AbstractSurefireMojo.java:854)
09:41:03,776 [ERROR] at org.apache.maven.plugin.DefaultBuildPluginManager.executeMojo(DefaultBuildPluginManager.java:134)
09:41:03,776 [ERROR] at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:207)
09:41:03,776 [ERROR] at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:153)
09:41:03,776 [ERROR] at org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:145)
09:41:03,776 [ERROR] at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:116)
09:41:03,776 [ERROR] at org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:80)
09:41:03,776 [ERROR] at org.apache.maven.lifecycle.internal.builder.singlethreaded.SingleThreadedBuilder.build(SingleThreadedBuilder.java:51)
09:41:03,776 [ERROR] at org.apache.maven.lifecycle.internal.LifecycleStarter.execute(LifecycleStarter.java:128)
09:41:03,776 [ERROR] at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:307)
09:41:03,776 [ERROR] at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:193)
09:41:03,776 [ERROR] at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:106)
09:41:03,777 [ERROR] at org.apache.maven.cli.MavenCli.execute(MavenCli.java:863)
09:41:03,777 [ERROR] at org.apache.maven.cli.MavenCli.doMain(MavenCli.java:288)
09:41:03,777 [ERROR] at org.apache.maven.cli.MavenCli.main(MavenCli.java:199)
09:41:03,777 [ERROR] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
09:41:03,777 [ERROR] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
09:41:03,777 [ERROR] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
09:41:03,777 [ERROR] at java.lang.reflect.Method.invoke(Method.java:497)
09:41:03,777 [ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.launchEnhanced(Launcher.java:289)
09:41:03,777 [ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.launch(Launcher.java:229)
09:41:03,778 [ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.mainWithExitCode(Launcher.java:415)
09:41:03,778 [ERROR] at org.codehaus.plexus.classworlds.launcher.Launcher.main(Launcher.java:356)
09:41:03,778 [ERROR] -> [Help 1]
09:41:03,778 [ERROR]
09:41:03,778 [ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
09:41:03,778 [ERROR] Re-run Maven using the -X switch to enable full debug logging.
09:41:03,778 [ERROR]
09:41:03,778 [ERROR] For more information about the errors and possible solutions, please read the following articles:
09:41:03,778 [ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoExecutionException

I created a bunch of commits for each version of surefire from 2.14 to 2.21.0 and using git bisect the issue appears to have been introduced in version 2.20.1.

git bisect start
git bisect bad 78be16941aec85476c201bc45246d4734b1b459c
git bisect good 6ea128a25cc876f5cbce552225775e886389c096
git bisect run ./Repro.cmd







--
This message was sent by Atlassian JIRA
(v7.6.3#76005)